builder: larch_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1464213712.21 results: success (0) buildid: 20160525123005 builduid: 8b7ae9ec020842eabe5e4a52199a9c66 revision: c3ee850b671f4544d9bb2587a1fc1a31700de10e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:52.214493) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:52.214968) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:52.215246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:52.230159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:52.230539) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1464213712.181084-28367724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 15:01:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.8M=0s 2016-05-25 15:01:53 (87.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179240 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:52.423795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:52.424130) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1464213712.181084-28367724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020610 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:52.470724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:52.471124) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev c3ee850b671f4544d9bb2587a1fc1a31700de10e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev c3ee850b671f4544d9bb2587a1fc1a31700de10e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1464213712.181084-28367724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 15:01:53,307 truncating revision to first 12 chars 2016-05-25 15:01:53,307 Setting DEBUG logging. 2016-05-25 15:01:53,307 attempt 1/10 2016-05-25 15:01:53,307 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/c3ee850b671f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 15:01:53,670 unpacking tar archive at: larch-c3ee850b671f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:53.190479) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:53.190841) ========= script_repo_revision: c3ee850b671f4544d9bb2587a1fc1a31700de10e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:53.191276) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:53.191608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 15:01:53.200214) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-25 15:01:53.200574) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Larch', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1464213712.181084-28367724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:01:54 INFO - MultiFileLogger online at 20160525 15:01:54 in /builds/slave/test 15:01:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 15:01:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:01:54 INFO - {'append_to_log': False, 15:01:54 INFO - 'base_work_dir': '/builds/slave/test', 15:01:54 INFO - 'blob_upload_branch': 'Larch', 15:01:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:01:54 INFO - 'branch': 'Larch', 15:01:54 INFO - 'buildbot_json_path': 'buildprops.json', 15:01:54 INFO - 'config_files': ('talos/linux_config.py',), 15:01:54 INFO - 'default_actions': ('clobber', 15:01:54 INFO - 'read-buildbot-config', 15:01:54 INFO - 'download-and-extract', 15:01:54 INFO - 'populate-webroot', 15:01:54 INFO - 'create-virtualenv', 15:01:54 INFO - 'install', 15:01:54 INFO - 'run-tests'), 15:01:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:01:54 INFO - 'download_minidump_stackwalk': True, 15:01:54 INFO - 'download_symbols': 'ondemand', 15:01:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:01:54 INFO - 'tooltool.py': '/tools/tooltool.py', 15:01:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:01:54 INFO - '/tools/misc-python/virtualenv.py')}, 15:01:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:01:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:01:54 INFO - 'installer_path': 'installer.exe', 15:01:54 INFO - 'log_level': 'info', 15:01:54 INFO - 'log_name': 'talos', 15:01:54 INFO - 'log_to_console': True, 15:01:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:01:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:01:54 INFO - 'opt_config_files': (), 15:01:54 INFO - 'pip_index': False, 15:01:54 INFO - 'sps_profile': False, 15:01:54 INFO - 'sps_profile_interval': 0, 15:01:54 INFO - 'suite': 'dromaeojs-e10s', 15:01:54 INFO - 'system_bits': '32', 15:01:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:01:54 INFO - 'title': 'talos-linux64-ix-056', 15:01:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:01:54 INFO - 'use_talos_json': True, 15:01:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:01:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:01:54 INFO - 'work_dir': 'build'} 15:01:54 INFO - ##### 15:01:54 INFO - ##### Running clobber step. 15:01:54 INFO - ##### 15:01:54 INFO - Running pre-action listener: _resource_record_pre_action 15:01:54 INFO - Running main action method: clobber 15:01:54 INFO - rmtree: /builds/slave/test/build 15:01:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:01:54 INFO - Running post-action listener: _resource_record_post_action 15:01:54 INFO - ##### 15:01:54 INFO - ##### Finished clobber step (success) 15:01:54 INFO - ##### 15:01:54 INFO - ##### 15:01:54 INFO - ##### Running read-buildbot-config step. 15:01:54 INFO - ##### 15:01:54 INFO - Running pre-action listener: _resource_record_pre_action 15:01:54 INFO - Running main action method: read_buildbot_config 15:01:54 INFO - Using buildbot properties: 15:01:54 INFO - { 15:01:54 INFO - "project": "", 15:01:54 INFO - "product": "firefox", 15:01:54 INFO - "script_repo_revision": "production", 15:01:54 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 15:01:54 INFO - "repository": "", 15:01:54 INFO - "buildername": "Ubuntu HW 12.04 x64 larch pgo talos dromaeojs-e10s", 15:01:54 INFO - "buildid": "20160525123005", 15:01:54 INFO - "pgo_build": "True", 15:01:54 INFO - "basedir": "/builds/slave/test", 15:01:54 INFO - "buildnumber": 2, 15:01:54 INFO - "slavename": "talos-linux64-ix-056", 15:01:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:01:54 INFO - "platform": "ubuntu64_hw", 15:01:54 INFO - "scheduler": "tests-larch-linux64-pgo-talos", 15:01:54 INFO - "branch": "larch", 15:01:54 INFO - "repo_path": "projects/larch", 15:01:54 INFO - "revision": "c3ee850b671f4544d9bb2587a1fc1a31700de10e", 15:01:54 INFO - "stage_platform": "linux64-pgo", 15:01:54 INFO - "builduid": "8b7ae9ec020842eabe5e4a52199a9c66", 15:01:54 INFO - "slavebuilddir": "test" 15:01:54 INFO - } 15:01:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:01:54 INFO - Running post-action listener: _resource_record_post_action 15:01:54 INFO - ##### 15:01:54 INFO - ##### Finished read-buildbot-config step (success) 15:01:54 INFO - ##### 15:01:54 INFO - ##### 15:01:54 INFO - ##### Running download-and-extract step. 15:01:54 INFO - ##### 15:01:54 INFO - Running pre-action listener: _resource_record_pre_action 15:01:54 INFO - Running main action method: download_and_extract 15:01:54 INFO - mkdir: /builds/slave/test/build/tests 15:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:54 INFO - https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:01:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:01:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:01:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:01:55 INFO - Downloaded 1361 bytes. 15:01:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:01:55 INFO - Using the following test package requirements: 15:01:55 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:01:55 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:01:55 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:01:55 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:55 INFO - u'jsshell-linux-x86_64.zip'], 15:01:55 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:01:55 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:01:55 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:01:55 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:01:55 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:01:55 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:55 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:01:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:55 INFO - https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:01:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:01:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:01:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:01:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:01:56 INFO - Downloaded 24420790 bytes. 15:01:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:01:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:01:58 INFO - Return code: 0 15:01:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:58 INFO - https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:01:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:01:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:01:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:01:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:01:59 INFO - Downloaded 24420790 bytes. 15:01:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:01:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:02:00 INFO - Return code: 0 15:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:00 INFO - https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:02:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:02:02 INFO - Downloaded 10834042 bytes. 15:02:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:02:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:02:02 INFO - Return code: 0 15:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:02 INFO - https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:02:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:02:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:02:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:02:06 INFO - Downloaded 58820800 bytes. 15:02:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:02:06 INFO - mkdir: /builds/slave/test/properties 15:02:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:02:06 INFO - Writing to file /builds/slave/test/properties/build_url 15:02:06 INFO - Contents: 15:02:06 INFO - build_url:https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:02:07 INFO - Running post-action listener: _resource_record_post_action 15:02:07 INFO - Running post-action listener: set_extra_try_arguments 15:02:07 INFO - ##### 15:02:07 INFO - ##### Finished download-and-extract step (success) 15:02:07 INFO - ##### 15:02:07 INFO - ##### 15:02:07 INFO - ##### Running populate-webroot step. 15:02:07 INFO - ##### 15:02:07 INFO - Running pre-action listener: _resource_record_pre_action 15:02:07 INFO - Running main action method: populate_webroot 15:02:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:02:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:02:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:02:07 INFO - '--tppagecycles', 15:02:07 INFO - '7'], 15:02:07 INFO - 'tests': ['tsvgm']}}, 15:02:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:02:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:02:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:02:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:02:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:02:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:02:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:07 INFO - 'talos_options': ['--disable-e10s'], 15:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:07 INFO - 'talos_options': ['--disable-e10s'], 15:02:07 INFO - 'tests': ['damp', 'tps']}, 15:02:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:07 INFO - 'tests': ['damp', 'tps']}, 15:02:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:02:07 INFO - 'tests': ['dromaeo_dom']}, 15:02:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:02:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:02:07 INFO - 'tests': ['a11yr', 15:02:07 INFO - 'ts_paint', 15:02:07 INFO - 'tpaint', 15:02:07 INFO - 'sessionrestore', 15:02:07 INFO - 'sessionrestore_no_auto_restore', 15:02:07 INFO - 'tabpaint']}, 15:02:07 INFO - 'other-e10s': {'tests': ['a11yr', 15:02:07 INFO - 'ts_paint', 15:02:07 INFO - 'tpaint', 15:02:07 INFO - 'sessionrestore', 15:02:07 INFO - 'sessionrestore_no_auto_restore', 15:02:07 INFO - 'tabpaint']}, 15:02:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:02:07 INFO - 'ts_paint', 15:02:07 INFO - 'tpaint', 15:02:07 INFO - 'sessionrestore', 15:02:07 INFO - 'sessionrestore_no_auto_restore', 15:02:07 INFO - 'tabpaint']}, 15:02:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:02:07 INFO - 'ts_paint', 15:02:07 INFO - 'tpaint', 15:02:07 INFO - 'sessionrestore', 15:02:07 INFO - 'sessionrestore_no_auto_restore', 15:02:07 INFO - 'tabpaint']}, 15:02:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:02:07 INFO - 'tests': ['a11yr', 15:02:07 INFO - 'ts_paint', 15:02:07 INFO - 'tpaint', 15:02:07 INFO - 'sessionrestore', 15:02:07 INFO - 'sessionrestore_no_auto_restore', 15:02:07 INFO - 'tabpaint']}, 15:02:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:02:07 INFO - 'tests': ['a11yr', 15:02:07 INFO - 'ts_paint', 15:02:07 INFO - 'tpaint', 15:02:07 INFO - 'sessionrestore', 15:02:07 INFO - 'sessionrestore_no_auto_restore', 15:02:07 INFO - 'tabpaint']}, 15:02:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:02:07 INFO - 'tests': ['tsvgx', 15:02:07 INFO - 'tsvgr_opacity', 15:02:07 INFO - 'tart', 15:02:07 INFO - 'tscrollx', 15:02:07 INFO - 'cart']}, 15:02:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:02:07 INFO - 'tsvgr_opacity', 15:02:07 INFO - 'tart', 15:02:07 INFO - 'tscrollx', 15:02:07 INFO - 'cart']}, 15:02:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:07 INFO - 'talos_options': ['--disable-e10s'], 15:02:07 INFO - 'tests': ['tp5o']}, 15:02:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:07 INFO - 'tests': ['tp5o']}, 15:02:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:07 INFO - 'talos_options': ['--disable-e10s', 15:02:07 INFO - '--xperf_path', 15:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:07 INFO - 'tests': ['tp5n']}, 15:02:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:07 INFO - 'talos_options': ['--xperf_path', 15:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:07 INFO - 'tests': ['tp5n']}}, 15:02:07 INFO - 'talos.zip': {'path': '', 15:02:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:02:07 INFO - Running post-action listener: _resource_record_post_action 15:02:07 INFO - ##### 15:02:07 INFO - ##### Finished populate-webroot step (success) 15:02:07 INFO - ##### 15:02:07 INFO - ##### 15:02:07 INFO - ##### Running create-virtualenv step. 15:02:07 INFO - ##### 15:02:07 INFO - Running pre-action listener: _resource_record_pre_action 15:02:07 INFO - Running main action method: create_virtualenv 15:02:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:02:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:02:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:02:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:02:07 INFO - Using real prefix '/usr' 15:02:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:02:07 INFO - Installing distribute.............................................................................................................................................................................................done. 15:02:09 INFO - Installing pip.................done. 15:02:09 INFO - Return code: 0 15:02:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa045b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21adb20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21aeeb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:02:09 INFO - Using env: {'DISPLAY': ':0', 15:02:09 INFO - 'HOME': '/home/cltbld', 15:02:09 INFO - 'LANG': 'en_US.UTF-8', 15:02:09 INFO - 'LANGUAGE': 'en_US:en', 15:02:09 INFO - 'LOGNAME': 'cltbld', 15:02:09 INFO - 'MAIL': '/var/mail/cltbld', 15:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:09 INFO - 'MOZ_NO_REMOTE': '1', 15:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:09 INFO - 'NO_EM_RESTART': '1', 15:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:09 INFO - 'PWD': '/builds/slave/test', 15:02:09 INFO - 'SHELL': '/bin/bash', 15:02:09 INFO - 'SHLVL': '1', 15:02:09 INFO - 'TERM': 'linux', 15:02:09 INFO - 'TMOUT': '86400', 15:02:09 INFO - 'USER': 'cltbld', 15:02:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 15:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:09 INFO - '_': '/tools/buildbot/bin/python'} 15:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:02:09 INFO - Cleaning up... 15:02:09 INFO - Return code: 0 15:02:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa045b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21adb20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21aeeb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:02:09 INFO - Using env: {'DISPLAY': ':0', 15:02:09 INFO - 'HOME': '/home/cltbld', 15:02:09 INFO - 'LANG': 'en_US.UTF-8', 15:02:09 INFO - 'LANGUAGE': 'en_US:en', 15:02:09 INFO - 'LOGNAME': 'cltbld', 15:02:09 INFO - 'MAIL': '/var/mail/cltbld', 15:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:09 INFO - 'MOZ_NO_REMOTE': '1', 15:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:09 INFO - 'NO_EM_RESTART': '1', 15:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:09 INFO - 'PWD': '/builds/slave/test', 15:02:09 INFO - 'SHELL': '/bin/bash', 15:02:09 INFO - 'SHLVL': '1', 15:02:09 INFO - 'TERM': 'linux', 15:02:09 INFO - 'TMOUT': '86400', 15:02:09 INFO - 'USER': 'cltbld', 15:02:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 15:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:09 INFO - '_': '/tools/buildbot/bin/python'} 15:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:10 INFO - Downloading/unpacking psutil>=3.1.1 15:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:02:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:12 INFO - Installing collected packages: psutil 15:02:12 INFO - Running setup.py install for psutil 15:02:12 INFO - building 'psutil._psutil_linux' extension 15:02:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:02:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:02:12 INFO - building 'psutil._psutil_posix' extension 15:02:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:02:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:02:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:12 INFO - Successfully installed psutil 15:02:12 INFO - Cleaning up... 15:02:12 INFO - Return code: 0 15:02:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa045b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21adb20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21aeeb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:02:12 INFO - Using env: {'DISPLAY': ':0', 15:02:12 INFO - 'HOME': '/home/cltbld', 15:02:12 INFO - 'LANG': 'en_US.UTF-8', 15:02:12 INFO - 'LANGUAGE': 'en_US:en', 15:02:12 INFO - 'LOGNAME': 'cltbld', 15:02:12 INFO - 'MAIL': '/var/mail/cltbld', 15:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:12 INFO - 'MOZ_NO_REMOTE': '1', 15:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:12 INFO - 'NO_EM_RESTART': '1', 15:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:12 INFO - 'PWD': '/builds/slave/test', 15:02:12 INFO - 'SHELL': '/bin/bash', 15:02:12 INFO - 'SHLVL': '1', 15:02:12 INFO - 'TERM': 'linux', 15:02:12 INFO - 'TMOUT': '86400', 15:02:12 INFO - 'USER': 'cltbld', 15:02:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 15:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:12 INFO - '_': '/tools/buildbot/bin/python'} 15:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:02:14 INFO - Installing collected packages: mozsystemmonitor 15:02:14 INFO - Running setup.py install for mozsystemmonitor 15:02:14 INFO - Successfully installed mozsystemmonitor 15:02:14 INFO - Cleaning up... 15:02:14 INFO - Return code: 0 15:02:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa045b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21adb20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21aeeb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:02:14 INFO - Using env: {'DISPLAY': ':0', 15:02:14 INFO - 'HOME': '/home/cltbld', 15:02:14 INFO - 'LANG': 'en_US.UTF-8', 15:02:14 INFO - 'LANGUAGE': 'en_US:en', 15:02:14 INFO - 'LOGNAME': 'cltbld', 15:02:14 INFO - 'MAIL': '/var/mail/cltbld', 15:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:14 INFO - 'MOZ_NO_REMOTE': '1', 15:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:14 INFO - 'NO_EM_RESTART': '1', 15:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:14 INFO - 'PWD': '/builds/slave/test', 15:02:14 INFO - 'SHELL': '/bin/bash', 15:02:14 INFO - 'SHLVL': '1', 15:02:14 INFO - 'TERM': 'linux', 15:02:14 INFO - 'TMOUT': '86400', 15:02:14 INFO - 'USER': 'cltbld', 15:02:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 15:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:14 INFO - '_': '/tools/buildbot/bin/python'} 15:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:15 INFO - Downloading/unpacking blobuploader==1.2.4 15:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:17 INFO - Downloading blobuploader-1.2.4.tar.gz 15:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:02:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:02:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:17 INFO - Downloading docopt-0.6.1.tar.gz 15:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:02:17 INFO - Installing collected packages: blobuploader, requests, docopt 15:02:17 INFO - Running setup.py install for blobuploader 15:02:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:02:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:02:17 INFO - Running setup.py install for requests 15:02:18 INFO - Running setup.py install for docopt 15:02:18 INFO - Successfully installed blobuploader requests docopt 15:02:18 INFO - Cleaning up... 15:02:18 INFO - Return code: 0 15:02:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa045b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21adb20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21aeeb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:02:18 INFO - Using env: {'DISPLAY': ':0', 15:02:18 INFO - 'HOME': '/home/cltbld', 15:02:18 INFO - 'LANG': 'en_US.UTF-8', 15:02:18 INFO - 'LANGUAGE': 'en_US:en', 15:02:18 INFO - 'LOGNAME': 'cltbld', 15:02:18 INFO - 'MAIL': '/var/mail/cltbld', 15:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:18 INFO - 'MOZ_NO_REMOTE': '1', 15:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:18 INFO - 'NO_EM_RESTART': '1', 15:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:18 INFO - 'PWD': '/builds/slave/test', 15:02:18 INFO - 'SHELL': '/bin/bash', 15:02:18 INFO - 'SHLVL': '1', 15:02:18 INFO - 'TERM': 'linux', 15:02:18 INFO - 'TMOUT': '86400', 15:02:18 INFO - 'USER': 'cltbld', 15:02:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 15:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:18 INFO - '_': '/tools/buildbot/bin/python'} 15:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:18 INFO - Running setup.py (path:/tmp/pip-BDT_yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:18 INFO - Running setup.py (path:/tmp/pip-0prHom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:18 INFO - Running setup.py (path:/tmp/pip-Uz3oEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:18 INFO - Running setup.py (path:/tmp/pip-hSvxRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:18 INFO - Running setup.py (path:/tmp/pip-zN3DDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:18 INFO - Running setup.py (path:/tmp/pip-1OVe1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:19 INFO - Running setup.py (path:/tmp/pip-d_WNku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:19 INFO - Running setup.py (path:/tmp/pip-TpNr0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:19 INFO - Running setup.py (path:/tmp/pip-MFiIRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:19 INFO - Running setup.py (path:/tmp/pip-FDzJTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:19 INFO - Running setup.py (path:/tmp/pip-XtzF_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:19 INFO - Running setup.py (path:/tmp/pip-JGcX6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:19 INFO - Running setup.py (path:/tmp/pip-8jYywj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:19 INFO - Running setup.py (path:/tmp/pip-kgIYOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:19 INFO - Running setup.py (path:/tmp/pip-i55TOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:19 INFO - Running setup.py (path:/tmp/pip-xJhfZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:19 INFO - Running setup.py (path:/tmp/pip-uuYn5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:02:19 INFO - Running setup.py install for manifestparser 15:02:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:02:19 INFO - Running setup.py install for mozcrash 15:02:20 INFO - Running setup.py install for mozdebug 15:02:20 INFO - Running setup.py install for mozdevice 15:02:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:02:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:02:20 INFO - Running setup.py install for mozfile 15:02:20 INFO - Running setup.py install for mozhttpd 15:02:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:02:20 INFO - Running setup.py install for mozinfo 15:02:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:02:20 INFO - Running setup.py install for mozInstall 15:02:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:02:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:02:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:02:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:02:20 INFO - Running setup.py install for mozleak 15:02:20 INFO - Running setup.py install for mozlog 15:02:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:02:20 INFO - Running setup.py install for moznetwork 15:02:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:02:20 INFO - Running setup.py install for mozprocess 15:02:21 INFO - Running setup.py install for mozprofile 15:02:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:02:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:02:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:02:21 INFO - Running setup.py install for mozrunner 15:02:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:02:21 INFO - Running setup.py install for mozscreenshot 15:02:21 INFO - Running setup.py install for moztest 15:02:21 INFO - Running setup.py install for mozversion 15:02:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:02:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:02:21 INFO - Cleaning up... 15:02:21 INFO - Return code: 0 15:02:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa045b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21adb20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21aeeb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:02:21 INFO - Using env: {'DISPLAY': ':0', 15:02:21 INFO - 'HOME': '/home/cltbld', 15:02:21 INFO - 'LANG': 'en_US.UTF-8', 15:02:21 INFO - 'LANGUAGE': 'en_US:en', 15:02:21 INFO - 'LOGNAME': 'cltbld', 15:02:21 INFO - 'MAIL': '/var/mail/cltbld', 15:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:21 INFO - 'MOZ_NO_REMOTE': '1', 15:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:21 INFO - 'NO_EM_RESTART': '1', 15:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:21 INFO - 'PWD': '/builds/slave/test', 15:02:21 INFO - 'SHELL': '/bin/bash', 15:02:21 INFO - 'SHLVL': '1', 15:02:21 INFO - 'TERM': 'linux', 15:02:21 INFO - 'TMOUT': '86400', 15:02:21 INFO - 'USER': 'cltbld', 15:02:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 15:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:21 INFO - '_': '/tools/buildbot/bin/python'} 15:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:21 INFO - Running setup.py (path:/tmp/pip-Zz0NIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:21 INFO - Running setup.py (path:/tmp/pip-M3Lly6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:21 INFO - Running setup.py (path:/tmp/pip-rwYbZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:22 INFO - Running setup.py (path:/tmp/pip-66Fiwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:22 INFO - Running setup.py (path:/tmp/pip-KgMTGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:22 INFO - Running setup.py (path:/tmp/pip-j5ZvBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:22 INFO - Running setup.py (path:/tmp/pip-pEAIcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:22 INFO - Running setup.py (path:/tmp/pip-aSztXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:22 INFO - Running setup.py (path:/tmp/pip-3OvHLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:22 INFO - Running setup.py (path:/tmp/pip-X4s5hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:22 INFO - Running setup.py (path:/tmp/pip-hnoLjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:22 INFO - Running setup.py (path:/tmp/pip-QYk0gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:22 INFO - Running setup.py (path:/tmp/pip-yAki49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:22 INFO - Running setup.py (path:/tmp/pip-DujaRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:22 INFO - Running setup.py (path:/tmp/pip-Fzmdtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:22 INFO - Running setup.py (path:/tmp/pip-YiVAji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:22 INFO - Running setup.py (path:/tmp/pip-Pl3uwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:02:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:24 INFO - Downloading blessings-1.6.tar.gz 15:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:02:25 INFO - Installing collected packages: blessings 15:02:25 INFO - Running setup.py install for blessings 15:02:25 INFO - Successfully installed blessings 15:02:25 INFO - Cleaning up... 15:02:25 INFO - Return code: 0 15:02:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:02:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:25 INFO - Reading from file tmpfile_stdout 15:02:25 INFO - Current package versions: 15:02:25 INFO - argparse == 1.2.1 15:02:25 INFO - blessings == 1.6 15:02:25 INFO - blobuploader == 1.2.4 15:02:25 INFO - docopt == 0.6.1 15:02:25 INFO - manifestparser == 1.1 15:02:25 INFO - mozInstall == 1.12 15:02:25 INFO - mozcrash == 0.17 15:02:25 INFO - mozdebug == 0.1 15:02:25 INFO - mozdevice == 0.48 15:02:25 INFO - mozfile == 1.2 15:02:25 INFO - mozhttpd == 0.7 15:02:25 INFO - mozinfo == 0.9 15:02:25 INFO - mozleak == 0.1 15:02:25 INFO - mozlog == 3.2 15:02:25 INFO - moznetwork == 0.27 15:02:25 INFO - mozprocess == 0.22 15:02:25 INFO - mozprofile == 0.28 15:02:25 INFO - mozrunner == 6.11 15:02:25 INFO - mozscreenshot == 0.1 15:02:25 INFO - mozsystemmonitor == 0.3 15:02:25 INFO - moztest == 0.7 15:02:25 INFO - mozversion == 1.4 15:02:25 INFO - psutil == 3.1.1 15:02:25 INFO - requests == 1.2.3 15:02:25 INFO - wsgiref == 0.1.2 15:02:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa045b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21adb20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21aeeb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:02:25 INFO - Using env: {'DISPLAY': ':0', 15:02:25 INFO - 'HOME': '/home/cltbld', 15:02:25 INFO - 'LANG': 'en_US.UTF-8', 15:02:25 INFO - 'LANGUAGE': 'en_US:en', 15:02:25 INFO - 'LOGNAME': 'cltbld', 15:02:25 INFO - 'MAIL': '/var/mail/cltbld', 15:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:25 INFO - 'MOZ_NO_REMOTE': '1', 15:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:25 INFO - 'NO_EM_RESTART': '1', 15:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:25 INFO - 'PWD': '/builds/slave/test', 15:02:25 INFO - 'SHELL': '/bin/bash', 15:02:25 INFO - 'SHLVL': '1', 15:02:25 INFO - 'TERM': 'linux', 15:02:25 INFO - 'TMOUT': '86400', 15:02:25 INFO - 'USER': 'cltbld', 15:02:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 15:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:25 INFO - '_': '/tools/buildbot/bin/python'} 15:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:02:25 INFO - Cleaning up... 15:02:25 INFO - Return code: 0 15:02:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa045b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21adb20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21aeeb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:02:25 INFO - Using env: {'DISPLAY': ':0', 15:02:25 INFO - 'HOME': '/home/cltbld', 15:02:25 INFO - 'LANG': 'en_US.UTF-8', 15:02:25 INFO - 'LANGUAGE': 'en_US:en', 15:02:25 INFO - 'LOGNAME': 'cltbld', 15:02:25 INFO - 'MAIL': '/var/mail/cltbld', 15:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:25 INFO - 'MOZ_NO_REMOTE': '1', 15:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:25 INFO - 'NO_EM_RESTART': '1', 15:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:25 INFO - 'PWD': '/builds/slave/test', 15:02:25 INFO - 'SHELL': '/bin/bash', 15:02:25 INFO - 'SHLVL': '1', 15:02:25 INFO - 'TERM': 'linux', 15:02:25 INFO - 'TMOUT': '86400', 15:02:25 INFO - 'USER': 'cltbld', 15:02:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 15:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:25 INFO - '_': '/tools/buildbot/bin/python'} 15:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:25 INFO - Downloading/unpacking jsonschema 15:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:02:27 INFO - Downloading/unpacking functools32 (from jsonschema) 15:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:27 INFO - Downloading functools32-3.2.3-2.tar.gz 15:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:02:27 INFO - warning: no files found matching '*.txt' 15:02:27 INFO - no previously-included directories found matching 'build' 15:02:27 INFO - no previously-included directories found matching 'dist' 15:02:27 INFO - no previously-included directories found matching '.git*' 15:02:28 INFO - Installing collected packages: jsonschema, functools32 15:02:28 INFO - Running setup.py install for functools32 15:02:28 INFO - warning: no files found matching '*.txt' 15:02:28 INFO - no previously-included directories found matching 'build' 15:02:28 INFO - no previously-included directories found matching 'dist' 15:02:28 INFO - no previously-included directories found matching '.git*' 15:02:28 INFO - Successfully installed jsonschema functools32 15:02:28 INFO - Cleaning up... 15:02:28 INFO - Return code: 0 15:02:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa045b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211e8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21adb20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21aeeb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:02:28 INFO - Using env: {'DISPLAY': ':0', 15:02:28 INFO - 'HOME': '/home/cltbld', 15:02:28 INFO - 'LANG': 'en_US.UTF-8', 15:02:28 INFO - 'LANGUAGE': 'en_US:en', 15:02:28 INFO - 'LOGNAME': 'cltbld', 15:02:28 INFO - 'MAIL': '/var/mail/cltbld', 15:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:28 INFO - 'MOZ_NO_REMOTE': '1', 15:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:28 INFO - 'NO_EM_RESTART': '1', 15:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:28 INFO - 'PWD': '/builds/slave/test', 15:02:28 INFO - 'SHELL': '/bin/bash', 15:02:28 INFO - 'SHLVL': '1', 15:02:28 INFO - 'TERM': 'linux', 15:02:28 INFO - 'TMOUT': '86400', 15:02:28 INFO - 'USER': 'cltbld', 15:02:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 15:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:28 INFO - '_': '/tools/buildbot/bin/python'} 15:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:28 INFO - Downloading/unpacking flake8 15:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:02:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:02:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:02:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:02:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:02:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:02:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:02:31 INFO - no previously-included directories found matching 'docs/_build' 15:02:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:02:31 INFO - Running setup.py install for pep8 15:02:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:02:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:02:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:02:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:02:31 INFO - no previously-included directories found matching 'docs/_build' 15:02:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:02:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:02:31 INFO - Cleaning up... 15:02:32 INFO - Return code: 0 15:02:32 INFO - Running post-action listener: _resource_record_post_action 15:02:32 INFO - Running post-action listener: _start_resource_monitoring 15:02:32 INFO - Starting resource monitoring. 15:02:32 INFO - ##### 15:02:32 INFO - ##### Finished create-virtualenv step (success) 15:02:32 INFO - ##### 15:02:32 INFO - ##### 15:02:32 INFO - ##### Running install step. 15:02:32 INFO - ##### 15:02:32 INFO - Running pre-action listener: _resource_record_pre_action 15:02:32 INFO - Running main action method: install 15:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:32 INFO - Reading from file tmpfile_stdout 15:02:32 INFO - Detecting whether we're running mozinstall >=1.0... 15:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:02:32 INFO - Reading from file tmpfile_stdout 15:02:32 INFO - Output received: 15:02:32 INFO - Usage: mozinstall [options] installer 15:02:32 INFO - Options: 15:02:32 INFO - -h, --help show this help message and exit 15:02:32 INFO - -d DEST, --destination=DEST 15:02:32 INFO - Directory to install application into. [default: 15:02:32 INFO - "/builds/slave/test"] 15:02:32 INFO - --app=APP Application being installed. [default: firefox] 15:02:32 INFO - mkdir: /builds/slave/test/build/application 15:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:02:49 INFO - Reading from file tmpfile_stdout 15:02:49 INFO - Output received: 15:02:49 INFO - /builds/slave/test/build/application/firefox/firefox 15:02:49 INFO - Running post-action listener: _resource_record_post_action 15:02:49 INFO - ##### 15:02:49 INFO - ##### Finished install step (success) 15:02:49 INFO - ##### 15:02:49 INFO - ##### 15:02:49 INFO - ##### Running run-tests step. 15:02:49 INFO - ##### 15:02:49 INFO - Running pre-action listener: _resource_record_pre_action 15:02:49 INFO - Running main action method: run_tests 15:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:49 INFO - Python 2.7.3 15:02:49 INFO - Return code: 0 15:02:49 INFO - grabbing minidump binary from tooltool 15:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:49 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21adb20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aea20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21aeeb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:02:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:02:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:02:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:49 INFO - Return code: 0 15:02:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:02:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:02:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:02:50 INFO - Return code: 0 15:02:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:02:50 INFO - Using env: {'DISPLAY': ':0', 15:02:50 INFO - 'HOME': '/home/cltbld', 15:02:50 INFO - 'LANG': 'en_US.UTF-8', 15:02:50 INFO - 'LANGUAGE': 'en_US:en', 15:02:50 INFO - 'LOGNAME': 'cltbld', 15:02:50 INFO - 'MAIL': '/var/mail/cltbld', 15:02:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:50 INFO - 'MOZ_NO_REMOTE': '1', 15:02:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:50 INFO - 'NO_EM_RESTART': '1', 15:02:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:50 INFO - 'PWD': '/builds/slave/test', 15:02:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:50 INFO - 'SHELL': '/bin/bash', 15:02:50 INFO - 'SHLVL': '1', 15:02:50 INFO - 'TERM': 'linux', 15:02:50 INFO - 'TMOUT': '86400', 15:02:50 INFO - 'USER': 'cltbld', 15:02:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464213712.181084-28367724', 15:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:50 INFO - '_': '/tools/buildbot/bin/python'} 15:02:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:02:50 INFO - mozversion application_buildid: 20160525123005 15:02:50 INFO - mozversion application_changeset: c3ee850b671f4544d9bb2587a1fc1a31700de10e 15:02:50 INFO - mozversion application_display_name: Nightly 15:02:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:50 INFO - mozversion application_name: Firefox 15:02:50 INFO - mozversion application_remotingname: firefox 15:02:50 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 15:02:50 INFO - mozversion application_vendor: Mozilla 15:02:50 INFO - mozversion application_version: 49.0a1 15:02:50 INFO - mozversion platform_buildid: 20160525123005 15:02:50 INFO - mozversion platform_changeset: c3ee850b671f4544d9bb2587a1fc1a31700de10e 15:02:50 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 15:02:50 INFO - mozversion platform_version: 49.0a1 15:02:50 INFO - using testdate: 1464213770 15:02:50 INFO - actual date: 1464213770 15:02:50 INFO - starting webserver on 'localhost:40878' 15:02:50 INFO - SUITE-START | Running 2 tests 15:02:50 INFO - TEST-START | dromaeo_css 15:02:50 INFO - operating with platform_type : linux_ 15:02:50 INFO - Initialising browser for dromaeo_css test... 15:02:50 INFO - TEST-INFO | started process 32665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSR2B2b/profile http://localhost:40878/getInfo.html) 15:02:54 INFO - PROCESS | 32665 | 15:02:54 INFO - PROCESS | 32665 | (process:32735): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:02:55 INFO - PROCESS | 32665 | __metrics Screen width/height:1600/1200 15:02:55 INFO - PROCESS | 32665 | colorDepth:24 15:02:55 INFO - PROCESS | 32665 | Browser inner width/height: 1024/697 15:02:55 INFO - PROCESS | 32665 | __metrics 15:02:55 ERROR - PROCESS | 32665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 15:02:56 INFO - TEST-INFO | 32665: exit 0 15:02:56 INFO - Browser initialized. 15:02:56 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:56 INFO - TEST-INFO | started process 318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSR2B2b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:58 INFO - PROCESS | 318 | 15:02:58 INFO - PROCESS | 318 | (process:378): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:03:08 INFO - PROCESS | 318 | RSS: Main: 165941248 15:03:08 INFO - PROCESS | 318 | 15:03:58 INFO - PROCESS | 318 | 1464213838153 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:06:05 INFO - PROCESS | 318 | Cycle 1(1): loaded http://localhost:40878/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40878/tests/dromaeo/cssquery-ext.html) 15:06:07 INFO - PROCESS | 318 | RSS: Main: 169672704 15:06:07 INFO - PROCESS | 318 | 15:09:09 INFO - PROCESS | 318 | Cycle 1(1): loaded http://localhost:40878/tests/dromaeo/cssquery-ext.html (next: http://localhost:40878/tests/dromaeo/cssquery-jquery.html) 15:09:09 INFO - PROCESS | 318 | RSS: Main: 169226240 15:09:09 INFO - PROCESS | 318 | 15:12:11 INFO - PROCESS | 318 | Cycle 1(1): loaded http://localhost:40878/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40878/tests/dromaeo/cssquery-mootools.html) 15:12:12 INFO - PROCESS | 318 | RSS: Main: 170651648 15:12:12 INFO - PROCESS | 318 | 15:15:14 INFO - PROCESS | 318 | Cycle 1(1): loaded http://localhost:40878/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40878/tests/dromaeo/cssquery-prototype.html) 15:15:14 INFO - PROCESS | 318 | RSS: Main: 167903232 15:15:14 INFO - PROCESS | 318 | 15:18:17 INFO - PROCESS | 318 | Cycle 1(1): loaded http://localhost:40878/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40878/tests/dromaeo/cssquery-yui.html) 15:18:17 INFO - PROCESS | 318 | RSS: Main: 169287680 15:18:17 INFO - PROCESS | 318 | 15:21:20 INFO - PROCESS | 318 | Cycle 1(1): loaded http://localhost:40878/tests/dromaeo/cssquery-yui.html (next: http://localhost:40878/tests/dromaeo/cssquery-dojo.html) 15:21:20 INFO - PROCESS | 318 | RSS: Main: 171438080 15:21:20 INFO - PROCESS | 318 | 15:21:20 INFO - PROCESS | 318 | __start_tp_report 15:21:20 INFO - PROCESS | 318 | _x_x_mozilla_page_load 15:21:20 INFO - PROCESS | 318 | _x_x_mozilla_page_load_details 15:21:20 INFO - PROCESS | 318 | |i|pagename|runs| 15:21:20 INFO - PROCESS | 318 | |0;dojo.html;3103.782735208535;3141.968580314196;3156.321390900956;3178.6185657721076;3199.120241933468;5373.220882971972;5389.703566303851;5424.159255315422;5429.267048948391;5605.859853503664;5344.599155063376;5350.491703288181;5353.812616558421;5383.650062745919;5405.837824865261;4853.902921941568;4969.527894849984;5077.060743762398;5086.084504789136;5141.691498510101;5087.669301495391;5191.818286359978;5193.58451323895;5196.3764348278255;5262.684238945675;4969.329140566031;5092.84721458355;5149.124648809711;5163.509466600685;5164.302819119408;5041.798328066873;5050.217216331474;5056.393232812049;5059.87350316245;5095.949040509585;5077.593792496591;5118.513741194581;5122.564582010534;5131.717755523445;5138.845834624967;5347.732613369355;5358.196270559447;5380.354357477088;5419.945800541984;5456.563474922036;5903.409659034105;5924.052151655757;5931.288245410578;5939;5948.31594366649;5952.345242023374;5964.493018093423;5968.97015514924;5975.073863551156;5982.312034116046;5316.734163291859;5524.171374293848;5562.582806289504;5606.495415412592;5662.5753068520025;6137.232845894263;6154.261488621394;6165.229346331708;6169.413905678954;6194.38056194386;5692.715364231772;5817.447342502455;5883.882322353529;5916.437938395846;5918.822435326947;5906.49794767441;5918.46733793952;6008.489278411384;6060.727267272983;6069.908951365733;5963.970180149072;5990.790322338785;6022.277326720821;6025.9096113558335;6040.365761595057;5739.081746920473;5792.275965504312;5994.970025149846;6022.909656355158;6061.090836374491;4351.216780979454;4435.844745433894;4442.444694413199;4484.798184081724;4497.977510112429;3996.7801770902297;4038.3336749436603;4048.8987775305263;4071.959280407217;4098.877033688994;5621.241132447149;5645.294338207724;5798.333191682926;5803.47768700819;5815.73829177688;6000.459958603747;6024.64445499759;6025.9397406026255;6026.969865150646;6108.175396321529;5673.631213971161;5709.0865461525955;5728.198052272685;5737.971310143423;5742.7415766290615;5049.697018178921;5051.26756620288;5091.592672586258;5129.820456284012;5160.974195129001;6160.199174107427;6167.938320616826;6177.011678131477;6182.845428864314;6184.165137706442;5962.423789971383;5996.850078748066;5997.400259973968;6006.279246490449;6031.5476339273855;6072.301685306246;6102.694865256808;6108.541859360477;6111.9816929085955;6160.229971253593;5797.9420205797405;5808.6224395414165;5850.414958504116;5911.172435859069;5953.255843019622;5883.29400471929;5943.881122377442;5958.940410596012;5995.760169593167;6059.21230240066;5678.858028549319;5712.228849105318;5736.053551164178;5750.137479378127;5793.507551858139;5766.913496297643;5791.536677065909;5803.100519419497;5823.82528524145;5830.300363956352;5531.0873705838085;5672.03575392176;5715.971420143039;5721.342045664802;5723.7996670116345;5688.601797874109;5743.511801496919;5759.337676167294;5787.739551720267;5805.593608447368;5616.915746263891;5706.229658996149;5707.914381284367;5713.542916566747;5803.709814509173 15:21:20 INFO - PROCESS | 318 | |1;ext.html;593.7506247376101;646.7413034786082;653.408665158032;657.8388294867758;669.5179470781039;38496.80751596241;42338.57661423385;42378.36432453508;42844.571554284485;43156.136877262514;42821.35767963483;43219;43408;43768.78115609426;43900.56099439005;8615.870761938577;8722.607482663263;8725.476471411705;8753.474791512497;8778.473291602524;8593.742187734379;8713.085126061767;8716.041235464094;8718.564071796416;8726.258268047224;8714.172153645393;8733.34499912506;8734.825303493926;8773.429727067753;8776.341774366949;8580.957095214515;8690.130986901322;8699.043105258417;8702.912970870273;8717.259032982203;8610;8645.783855403603;8668.219860212548;8705;8713.4336268143;32201.838990804896;40451.7977410114;40778.38832417516;40992;41136;3355.6644335566493;3437.7765445245977;3848.2111167210655;4149.605787450188;4297.656187504992;31358;31532.36935261305;32252.516212256836;32720;32806.34387312264;3840.2511510255513;3899.161680238734;3915.275674000319;3961.524617045944;4104.076582768883;294888.1022379562;296818;297135;297961.51019244984;298541;34180.658193417745;34757.30485390328;35016;35204;35386;36920.44619330712;37159.071023224096;37211.81394093066;37263.25473490515;37318.62681373206;14945.626359340886;15236.085834849944;15249.6187595311;15253.08481491114;15289.08265504051;12399.132060755841;12554.121211515107;12568.560100396442;12596.055295852664;12602.621921342374;8263.917360826435;8368;8371.706990255312;8405.663773448994;8413.915860841436;3241.789283696552;3241.8054916705073;3254.332861763333;3286.704196622268;3317.0712200583876;1044.4464433850071;1054.7943151085617;1082.832161015044;1083.0685610375072;1160.2458402038742;32972.3405531888;33245.1205767425;33371.16572085717;33467.64114818177;33751.66248337485;1100.8568886044764;1108.1910205549993;1130.2822707580744;1177.2053863642006;1181.988180118205;16606.335746570003;16845.831541684427;16938;16983.91508042452;17203.569910752332;544742;551485;554538;554768;555136;58748.4125158743;58806.41193588095;59089;59243.40756592465;59279;1343.9664008399868;1394.8186735724291;1395.483671041721;1402.8246469191351;1404.9297535123203;30187.69812301849;31451.685483144876;31642.683573163973;31708.682913170574;32264.193395165308;51034.74482627563;54207;55994.44005559892;56325.71837140788;62109.689451552455;462486;465911;466474;467505;470558;44682.77658611686;44865;45202.54797451983;45266.54733452755;46292.07415851732;49599;49627.75186124046;50351.74824125856;50795.74602126966;50988;41598;41685.58314416817;42955.7852210737;43727.469538565994;44398.55601443944;41860.372094418;42470.5752942479;42542;42985.140297193255;43211.35182972195;42341;42713.78643106889;43645;43949.56050439455;44015.77992110019;36051.45922811212;37574.24851503009;37590.812045939594;38141.80929095448;38195.809020954715;28246.610406751322;29208.853955730086;29234.853825730734;29259;29374.118776435887 15:21:20 INFO - PROCESS | 318 | |2;jquery.html;391.2956677979636;392.174472734893;393.264595206963;401.8734098758891;422.3896469601425;13728.244946527937;18392.540186495327;18739.718904216414;19690.11394487248;19845;18394.724079138825;18629.44111676652;18944.336948206816;19601.607967840635;19651.31220407286;5655.349634792;5719.828405147852;5813.215215945836;5829.0964900440285;5835.854103647401;5358.2498450217;5644.971775141139;5739.512141467981;5760;5807.30312362515;5679.801206957757;5684.261046064006;5688.345840228385;5704.172894930232;5706.258186435757;5626.578006649497;5667.716614169296;5671.829845104653;5696.51579615731;5755.280589926259;5387.488188622075;5443;5497.587680923947;5514.035043867348;5517.44825517445;12122.636320910387;19947.9028653424;20934.790652093438;22367.440813979618;22445.551088978293;2119.3853782403085;2239.6749498302806;2256.9322920312416;2544.109561653425;2827.377976845091;9095.499747513884;9326.766830829216;9607.807843843084;9804.558794854178;13965.860341396557;1881.5578339090303;1885.792562818089;1890.4234208566381;1899.943001709951;1981.1382048808814;74939;80362;81024.78462823121;82216;82259;10454.634087807042;10647.361158330525;10682.679519614425;10707;11081.833772493419;14918.850811491746;15018;15042;15101.169435680924;15162.620934476727;7420.5547667140145;7710.113336966208;7870.606469676608;7940.1662825403655;7947.682092716343;7274.59989700561;7298.270172982766;7300.452466065067;7528.924710752823;7588.241175882367;4567.36056952027;4602.286645569942;4671.743054131987;4684.110019096361;4700.623950083985;1750.614864729783;1954.7947465515915;1985.8808471491757;2000.479875232421;2032.6950957356514;912.1516989200107;987.4766373821886;1001.1990407673832;1056.1603525197334;1117.435694974033;18359.724604130948;18697.532561685795;19022.809771902103;19453.902730486257;19616.411507654793;995.4326034160604;1030.4281123976266;1030.685640879524;1064.8455973883742;1075.1882328841675;9732.172765315028;10883.583216588659;10914.890851091388;10922.890771092347;11026.117910567136;416964;435506;441428;444624;447202;85947.57026214829;87484.1251587476;87710;88285.55857220673;89617;1012.1649639047815;1019.6940917724653;1041.890601486848;1068.7915856407926;1073.7154654016692;16797.41209057726;17142.571435713708;17211.225494853014;17366.21852016637;17523.56191095233;39286.41070384004;39970.40044399278;41488.585114148475;41650.791746041075;41885.58114418817;56031.15953260786;57033;58458.415415845295;58475.70762146162;58931.705341474735;7638.770836874903;7868;7908.044149934873;8124.675012999413;8318.334533237448;12250.387480626112;12648.557300494438;12703.618891433272;12760;12917.28954907489;11090.556377745123;11323.660290191307;11389.145814063813;11460.598879039193;11497.712557186138;10848.837267440837;10971.561137554409;10984.670459886216;10989.120870330515;11098.778024439627;11362.55705023424;11412.885871141183;11424.371659558805;11466.82799758021;11617.88382116168;7517.661705223388;7591.734289299848;7658.846823063619;7876.56678882667;8337.916620833714;7801;10498;11037.503312351124;11077.446127693744;11090.390028548507 15:21:20 INFO - PROCESS | 318 | |3;mootools.html;1504.6313653154975;1532.210911380639;1645.6050547868515;1804.0618878183336;1808.3580328983203;7997.280244777969;8539.103394143618;8616.224539791418;9240;9260;8674.219320261176;8924.375293729441;8979.191872731453;8988.505632190227;8994.820103597924;2264.094362255095;2278.1456953642382;2286.119843860109;2290.278562252885;2292.6446400807818;2225.4992626658955;2259.197984715427;2289.381866895937;2297.5519773644146;2306.746257911628;2229.1863469833474;2247.8538894971857;2257.4243567890167;2272.125231785766;2287;2202.526456811785;2206.3380985704225;2215.8559693619945;2233.1848875160613;2237.451824303048;2187.9671804922937;2204.7574766775642;2211.2150186683816;2226.7216597925258;2230.397792596006;8836;8878.334124940655;8922.910770892338;8926.821463570757;8942.463452192824;5114.744262786846;5211.661242019294;5224.399194092652;5230.08473517133;5239.895202095975;3130.4052230076213;3175.42842288388;3314.254292784128;3320.286138480214;3332.41682705528;1096.3915027159924;1142.457332766929;1146.2606618730872;1148.2306854407484;1174.424531979324;12358.75282494354;12448.377581120998;12458.12793104483;12495.75008499834;12529.561465348761;4352.564743525622;4502.57225563571;4520.977395113069;4529.54704529551;4546.909061818745;10362.171026317876;10429.37423754562;10433.686989390331;10461.110805581458;10516.68449946503;5167.328247327823;5188.403333616607;5192.169252919591;5232.947670523246;5244.265802787613;4335.9349609755245;4664.580187783115;4806.134895718804;4854.8786280342565;4894.877628059327;3956.1494278729638;3986.940195897064;4029.7783621901076;4062.370332598452;4087.6729861611;1206.7164216409137;1223.804191329383;1229.5450683247257;1237.424597562138;1238.3468070126303;1008.8991100889999;1008.9899101009042;1037.4501514197486;1040.9323393979366;1049.2497864027257;6132;6223.377662233831;6332.715027823759;6371.872562548723;6417.903731444032;432.27809558038155;435.86923922823024;439.32344189947764;442.5861819199059;449.3327408797932;4309.396684464177;4364.214441400578;4396.4284642996845;4401.405810215644;4424.845130420485;11059.336439813636;11283.210175287652;11342.659720208407;11379.601713939972;11415;10982.395968221825;11138.554457821758;11254;11283.717907052389;11313.83029254562;8173.060098088677;8326.084130745614;8382.245597896097;8453.70412035588;8501.852249946302;6069.119977603311;6103.786367477117;6119.969400153149;6177.96911015442;6233;10241.795164096826;10280.537375817956;10347.84478232812;10350.016748408889;10436.94781526118;10202.540885660312;10526.210534210119;10548.085840826578;10650.360978341325;10702.464876756287;7084.25615310385;7643.694252229849;7892.092409372766;7901.17037711055;8026.8795968061695;8802.38383313162;8802.427842190236;8831.64673413082;8917;8932.821343573221;7600.619969001638;7740.109887363025;7775.261350171724;7834.804129896798;8070.1122876484715;7692.846143076995;7859.17478664732;7860.9213907860185;7893.842123157619;7898.091719452336;6987.161540615159;7006.229314775473;7015.473839461959;7036.155661320674;7046.682899269443;5220.504052115043;5372.731363431891;5499.120140777456;5516.0071187186695;5644.181593668977;5293.550048245942;5301.575873930154;5304.893902122013;5335.786568537215;5413.215083812746 15:21:20 INFO - PROCESS | 318 | |4;prototype.html;301.4498540164201;314.06408901473594;314.1235951694772;332.64573229510574;332.96337402885683;5615.971920140393;5624.481390024691;5636.351819540754;5649.548036157108;5650.660960342382;5507.54914063242;5532.972335138329;5551.555875529958;5573.08044172712;5603.663780173182;4150.418941348214;4190.308599081148;4276.572342765714;4288.785560721967;4329.19909816685;4267.957320426803;4306.160298741746;4310.224159651261;4327.826886924519;4331.678837954422;4238.470191226097;4267.530571637118;4284.935725964113;4288.463942007249;4305.375720520523;4032.2741906456827;4252.2345977724;4266.210751011073;4295.871123866289;4333.198358303724;3671.3391589513876;3706.9629303707156;3722.1253005543676;3726.2547490502006;3730.7201959852846;5339.733013349317;5347.438518955492;5348.91976620351;5364.704941228231;5393.649412788156;4603.171429142753;4879.414470263591;4896.3145159677315;4904.877378065541;4915.066137433876;5688.4311568843195;5756.971215143939;5756.971215143939;5762.711864406763;5858.619189752695;4072.328065869128;4081.9386209963777;4153.54311025787;4163.3130533461945;4182.53611236068;5979.970100149515;6059.757609695607;6078.149059131725;6085.57400981927;6087.934611443024;4081.6326530611796;4083.816228269735;4102.569230230843;4119.505659320841;4131.194417088639;4104.876853694334;4141.8964525886495;4155.8337666493;4195.790210489463;4233.936490952638;4690.061987602493;4851.927221091686;4874.439439464436;4906.969536397325;4951.158303088484;5751.22358481608;5812.651240925558;5815.563832712563;5834.795782147605;5850.619709718854;1443.7256921184942;1450.2966061460183;1460.3793387810351;1463.3853781411833;1480.267267702494;936.5176933879058;941.9340646154703;958.4680502321279;959.2565761534727;981.5975450065439;5532.197831314437;5541.445855414507;5541.501264886179;5617.943820561742;5633.859153521113;5856.677882716406;5947.82156535296;5953.166556682068;5959.791407300723;5999.310079340931;5297.470252974672;5643.322801263875;5652.604317697722;5654.491095801398;5671.319441667027;3170.3183815479783;3174.952375714366;3177.5710279112486;3208.6149662040702;3228.4027454920447;5957.940420595825;6092;6211.782587609412;6226.968865155736;6251.9687401562705;6037.63774173551;6038.18484504595;6062.333143354227;6091.208142941389;6118.296395914527;6095.390460953958;6183.3923179973535;6204.565680402328;6211.16149319845;6222.284437289679;5647.632903861236;5901.675407852609;5912.231409916683;5933.703314834327;5953.958057340034;5828.94171058301;5841.32824725162;5854.092615644582;5857.677827719516;5867.647941123546;5945.910811337747;6096.177016102769;6115.724792384264;6205.689715514116;6229.221347331583;4140.4617399737845;4150.730202536825;4166.68749843769;4172.520160181618;4172.915042089018;5929.377415371324;6070.7875224366935;6100;6100.633961962297;6105.877882442237;5610.747516361856;5855.94144058554;5873.588848780544;5895.02732049207;5901.380355062828;5745.942540574708;5879.764809407576;5883.323417807007;5893.557983151195;5902.763889444374;5580.330360356783;5674.602777805679;5747.166660834072;5805.593608447368;5828.504577110823;5813.6221145625395;5854.268216472941;5859.589828711949;5873.148393483007;5874.706264686834;5603.80386686464;5727.971360143172;5740.569457290803;5743.6840973745175;5752.942470575241 15:21:20 INFO - PROCESS | 318 | |5;yui.html;816.8366326734654;821.0803899632413;840.252175563748;842.3555979675549;869.934754893383;14298.499552515665;14895.92552037241;14908.776368354456;15048.097114173157;15097.62255943602;13409.932950335235;13633.318334083306;13820.447182112703;13897.513587024456;13985.510507132252;796.1719811396156;809.7935026568247;812.7642983534797;812.9105798362175;813.324940299553;786.3512602103259;788.4796034617153;792.18405042806;800.7037396163428;801.7875263055295;841.7937605286713;844.5777111444278;847.6439895244013;847.7668641123679;849.1169184048582;840.6217202259008;841.6549214821924;842.1031601344548;842.7893026743315;843.4180415513276;605.4036773777825;608.9725962331705;609.3114780298234;609.838392825897;611.9627231842029;13247.867521324855;13267.402966866417;13381.799273010913;13415.597532074053;13418;11973.221740586834;12109.03127749778;12243.449044793006;12250.326232057234;12441.440135193938;9936.701898943043;11053.28153670017;11125.276857004268;11375.544978200945;11646.184767066308;4285.9785701071605;4291.570842915715;4317.071829556629;4349.391085248068;4467.888302792456;54685.45314546843;55700.44299557034;55838.20808959576;60047.69976150091;61239;11009.637766573971;11141;11153.888461115448;11205.383703896365;11253.774924501464;19055.047247637838;19068.14193361302;19081.61836763257;19083.141258643394;19155.61688766217;8147.959260203661;8227;8285.751427457186;8366.330693544502;8416.621252043673;4646.697964632288;4674.322223277606;4710.9764451177525;4733;4900.26496025599;3285.14586207583;3355.8825441109443;3361.714254288413;3362.69735723786;3385.7629965902643;626.5582764151262;628.3622123544606;634.7936920500763;647.6405594894878;650.6291413894035;658.887989041864;667.7028722218663;772.8664427335723;777.0869228656419;793.5318162284279;8897.599608017656;9181.770455738526;9308.8603670945;9535.427874327563;9634.181094607036;766.1074847802248;772.7681695491331;791.8930944322558;799.4763429953274;804.3565147881789;4573.405457290531;4588.564086411786;4769.165396055676;4820.855374338776;4859.2954021666665;67397.3260267391;68664;68968.6551567239;69590;70934.2906570938;59938.70030649819;62158.37841621616;62279.377206228266;62899.37100629027;63371.683141584;57018.42981570214;57170.71414642983;57479.425205748244;58078.709606451695;58788.35452404652;8812.779680508038;9095.909040909772;9118.635254589743;9139.497327647043;9203.815923681623;36653;36853.815730921175;37257.813710931274;37369;37667.43498847465;45608;47598.52401475941;49817.25274120964;49837.252441214136;50405.49594504008;10634.468276585985;11165.609203677832;11340.6030788922;11577.07383409342;11688.88311116878;12270.509179632714;12899;12969.805452918024;13343.733125337245;13354.93322533381;11651.41742912868;12085.978505373656;12364.072694547765;12418.447694038245;12591;11681.88318116808;11791.823122652995;11871.821922670993;11964.940175299067;12597.811032834332;11120.332780033224;11120.61077862271;11190.720231994264;11236.66290011301;11832.290062596272;9886.4562449066;10194.541245643815;10198.490075496344;10203.38779673222;10438.895611044096;10141.695749127539;10258.076773090457;10286;10443.425611591132;10464.372137671764 15:21:20 INFO - PROCESS | 318 | __end_tp_report 15:21:20 INFO - PROCESS | 318 | __start_cc_report 15:21:20 INFO - PROCESS | 318 | _x_x_mozilla_cycle_collect,357 15:21:20 INFO - PROCESS | 318 | __end_cc_report 15:21:20 INFO - PROCESS | 318 | __startTimestamp1464214880700__endTimestamp 15:21:20 INFO - PROCESS | 318 | 15:21:20 INFO - PROCESS | 318 | ------- Summary: start ------- 15:21:20 INFO - PROCESS | 318 | Number of tests: 6 15:21:20 INFO - PROCESS | 318 | 15:21:20 INFO - PROCESS | 318 | [#0] dojo.html Cycles:165 Average:5518.22 Median:5728.20 stddev:643.36 (11.2%) stddev-sans-first:616.82 15:21:20 INFO - PROCESS | 318 | Values: 3103.8 3142.0 3156.3 3178.6 3199.1 5373.2 5389.7 5424.2 5429.3 5605.9 5344.6 5350.5 5353.8 5383.7 5405.8 4853.9 4969.5 5077.1 5086.1 5141.7 5087.7 5191.8 5193.6 5196.4 5262.7 4969.3 5092.8 5149.1 5163.5 5164.3 5041.8 5050.2 5056.4 5059.9 5095.9 5077.6 5118.5 5122.6 5131.7 5138.8 5347.7 5358.2 5380.4 5419.9 5456.6 5903.4 5924.1 5931.3 5939.0 5948.3 5952.3 5964.5 5969.0 5975.1 5982.3 5316.7 5524.2 5562.6 5606.5 5662.6 6137.2 6154.3 6165.2 6169.4 6194.4 5692.7 5817.4 5883.9 5916.4 5918.8 5906.5 5918.5 6008.5 6060.7 6069.9 5964.0 5990.8 6022.3 6025.9 6040.4 5739.1 5792.3 5995.0 6022.9 6061.1 4351.2 4435.8 4442.4 4484.8 4498.0 3996.8 4038.3 4048.9 4072.0 4098.9 5621.2 5645.3 5798.3 5803.5 5815.7 6000.5 6024.6 6025.9 6027.0 6108.2 5673.6 5709.1 5728.2 5738.0 5742.7 5049.7 5051.3 5091.6 5129.8 5161.0 6160.2 6167.9 6177.0 6182.8 6184.2 5962.4 5996.9 5997.4 6006.3 6031.5 6072.3 6102.7 6108.5 6112.0 6160.2 5797.9 5808.6 5850.4 5911.2 5953.3 5883.3 5943.9 5958.9 5995.8 6059.2 5678.9 5712.2 5736.1 5750.1 5793.5 5766.9 5791.5 5803.1 5823.8 5830.3 5531.1 5672.0 5716.0 5721.3 5723.8 5688.6 5743.5 5759.3 5787.7 5805.6 5616.9 5706.2 5707.9 5713.5 5803.7 15:21:20 INFO - PROCESS | 318 | 15:21:20 INFO - PROCESS | 318 | [#1] ext.html Cycles:180 Average:59080.76 Median:41641.79 stddev:120084.37 (288.4%) stddev-sans-first:120340.94 15:21:20 INFO - PROCESS | 318 | Values: 593.8 646.7 653.4 657.8 669.5 38496.8 42338.6 42378.4 42844.6 43156.1 42821.4 43219.0 43408.0 43768.8 43900.6 8615.9 8722.6 8725.5 8753.5 8778.5 8593.7 8713.1 8716.0 8718.6 8726.3 8714.2 8733.3 8734.8 8773.4 8776.3 8581.0 8690.1 8699.0 8702.9 8717.3 8610.0 8645.8 8668.2 8705.0 8713.4 32201.8 40451.8 40778.4 40992.0 41136.0 3355.7 3437.8 3848.2 4149.6 4297.7 31358.0 31532.4 32252.5 32720.0 32806.3 3840.3 3899.2 3915.3 3961.5 4104.1 294888.1 296818.0 297135.0 297961.5 298541.0 34180.7 34757.3 35016.0 35204.0 35386.0 36920.4 37159.1 37211.8 37263.3 37318.6 14945.6 15236.1 15249.6 15253.1 15289.1 12399.1 12554.1 12568.6 12596.1 12602.6 8263.9 8368.0 8371.7 8405.7 8413.9 3241.8 3241.8 3254.3 3286.7 3317.1 1044.4 1054.8 1082.8 1083.1 1160.2 32972.3 33245.1 33371.2 33467.6 33751.7 1100.9 1108.2 1130.3 1177.2 1182.0 16606.3 16845.8 16938.0 16983.9 17203.6 544742.0 551485.0 554538.0 554768.0 555136.0 58748.4 58806.4 59089.0 59243.4 59279.0 1344.0 1394.8 1395.5 1402.8 1404.9 30187.7 31451.7 31642.7 31708.7 32264.2 51034.7 54207.0 55994.4 56325.7 62109.7 462486.0 465911.0 466474.0 467505.0 470558.0 44682.8 44865.0 45202.5 45266.5 46292.1 49599.0 49627.8 50351.7 50795.7 50988.0 41598.0 41685.6 42955.8 43727.5 44398.6 41860.4 42470.6 42542.0 42985.1 43211.4 42341.0 42713.8 43645.0 43949.6 44015.8 36051.5 37574.2 37590.8 38141.8 38195.8 28246.6 29208.9 29234.9 29259.0 29374.1 15:21:20 INFO - PROCESS | 318 | 15:21:20 INFO - PROCESS | 318 | [#2] jquery.html Cycles:180 Average:27051.76 Median:1609.34 stddev:72356.10 (4496.0%) stddev-sans-first:72531.39 15:21:20 INFO - PROCESS | 318 | Values: 391.3 392.2 393.3 401.9 422.4 13728.2 18392.5 18739.7 19690.1 19845.0 18394.7 18629.4 18944.3 19601.6 19651.3 5655.3 5719.8 5813.2 5829.1 5835.9 5358.2 5645.0 5739.5 5760.0 5807.3 5679.8 5684.3 5688.3 5704.2 5706.3 5626.6 5667.7 5671.8 5696.5 5755.3 5387.5 5443.0 5497.6 5514.0 5517.4 12122.6 19947.9 20934.8 22367.4 22445.6 2119.4 2239.7 2256.9 2544.1 2827.4 9095.5 9326.8 9607.8 9804.6 13965.9 1881.6 1885.8 1890.4 1899.9 1981.1 74939.0 80362.0 81024.8 82216.0 82259.0 10454.6 10647.4 10682.7 10707.0 11081.8 14918.9 15018.0 15042.0 15101.2 15162.6 7420.6 7710.1 7870.6 7940.2 7947.7 7274.6 7298.3 7300.5 7528.9 7588.2 4567.4 4602.3 4671.7 4684.1 4700.6 1750.6 1954.8 1985.9 2000.5 2032.7 912.2 987.5 1001.2 1056.2 1117.4 18359.7 18697.5 19022.8 19453.9 19616.4 995.4 1030.4 1030.7 1064.8 1075.2 9732.2 10883.6 10914.9 10922.9 11026.1 416964.0 435506.0 441428.0 444624.0 447202.0 85947.6 87484.1 87710.0 88285.6 89617.0 1012.2 1019.7 1041.9 1068.8 1073.7 16797.4 17142.6 17211.2 17366.2 17523.6 39286.4 39970.4 41488.6 41650.8 41885.6 56031.2 57033.0 58458.4 58475.7 58931.7 7638.8 7868.0 7908.0 8124.7 8318.3 12250.4 12648.6 12703.6 12760.0 12917.3 11090.6 11323.7 11389.1 11460.6 11497.7 10848.8 10971.6 10984.7 10989.1 11098.8 11362.6 11412.9 11424.4 11466.8 11617.9 7517.7 7591.7 7658.8 7876.6 8337.9 7801.0 10498.0 11037.5 11077.4 11090.4 15:21:20 INFO - PROCESS | 318 | 15:21:20 INFO - PROCESS | 318 | [#3] mootools.html Cycles:180 Average:5878.31 Median:2401.77 stddev:3408.01 (141.9%) stddev-sans-first:3401.72 15:21:20 INFO - PROCESS | 318 | Values: 1504.6 1532.2 1645.6 1804.1 1808.4 7997.3 8539.1 8616.2 9240.0 9260.0 8674.2 8924.4 8979.2 8988.5 8994.8 2264.1 2278.1 2286.1 2290.3 2292.6 2225.5 2259.2 2289.4 2297.6 2306.7 2229.2 2247.9 2257.4 2272.1 2287.0 2202.5 2206.3 2215.9 2233.2 2237.5 2188.0 2204.8 2211.2 2226.7 2230.4 8836.0 8878.3 8922.9 8926.8 8942.5 5114.7 5211.7 5224.4 5230.1 5239.9 3130.4 3175.4 3314.3 3320.3 3332.4 1096.4 1142.5 1146.3 1148.2 1174.4 12358.8 12448.4 12458.1 12495.8 12529.6 4352.6 4502.6 4521.0 4529.5 4546.9 10362.2 10429.4 10433.7 10461.1 10516.7 5167.3 5188.4 5192.2 5232.9 5244.3 4335.9 4664.6 4806.1 4854.9 4894.9 3956.1 3986.9 4029.8 4062.4 4087.7 1206.7 1223.8 1229.5 1237.4 1238.3 1008.9 1009.0 1037.5 1040.9 1049.2 6132.0 6223.4 6332.7 6371.9 6417.9 432.3 435.9 439.3 442.6 449.3 4309.4 4364.2 4396.4 4401.4 4424.8 11059.3 11283.2 11342.7 11379.6 11415.0 10982.4 11138.6 11254.0 11283.7 11313.8 8173.1 8326.1 8382.2 8453.7 8501.9 6069.1 6103.8 6120.0 6178.0 6233.0 10241.8 10280.5 10347.8 10350.0 10436.9 10202.5 10526.2 10548.1 10650.4 10702.5 7084.3 7643.7 7892.1 7901.2 8026.9 8802.4 8802.4 8831.6 8917.0 8932.8 7600.6 7740.1 7775.3 7834.8 8070.1 7692.8 7859.2 7860.9 7893.8 7898.1 6987.2 7006.2 7015.5 7036.2 7046.7 5220.5 5372.7 5499.1 5516.0 5644.2 5293.6 5301.6 5304.9 5335.8 5413.2 15:21:20 INFO - PROCESS | 318 | 15:21:20 INFO - PROCESS | 318 | [#4] prototype.html Cycles:180 Average:4875.90 Median:5635.11 stddev:1458.55 (25.9%) stddev-sans-first:1421.65 15:21:20 INFO - PROCESS | 318 | Values: 301.4 314.1 314.1 332.6 333.0 5616.0 5624.5 5636.4 5649.5 5650.7 5507.5 5533.0 5551.6 5573.1 5603.7 4150.4 4190.3 4276.6 4288.8 4329.2 4268.0 4306.2 4310.2 4327.8 4331.7 4238.5 4267.5 4284.9 4288.5 4305.4 4032.3 4252.2 4266.2 4295.9 4333.2 3671.3 3707.0 3722.1 3726.3 3730.7 5339.7 5347.4 5348.9 5364.7 5393.6 4603.2 4879.4 4896.3 4904.9 4915.1 5688.4 5757.0 5757.0 5762.7 5858.6 4072.3 4081.9 4153.5 4163.3 4182.5 5980.0 6059.8 6078.1 6085.6 6087.9 4081.6 4083.8 4102.6 4119.5 4131.2 4104.9 4141.9 4155.8 4195.8 4233.9 4690.1 4851.9 4874.4 4907.0 4951.2 5751.2 5812.7 5815.6 5834.8 5850.6 1443.7 1450.3 1460.4 1463.4 1480.3 936.5 941.9 958.5 959.3 981.6 5532.2 5541.4 5541.5 5617.9 5633.9 5856.7 5947.8 5953.2 5959.8 5999.3 5297.5 5643.3 5652.6 5654.5 5671.3 3170.3 3175.0 3177.6 3208.6 3228.4 5957.9 6092.0 6211.8 6227.0 6252.0 6037.6 6038.2 6062.3 6091.2 6118.3 6095.4 6183.4 6204.6 6211.2 6222.3 5647.6 5901.7 5912.2 5933.7 5954.0 5828.9 5841.3 5854.1 5857.7 5867.6 5945.9 6096.2 6115.7 6205.7 6229.2 4140.5 4150.7 4166.7 4172.5 4172.9 5929.4 6070.8 6100.0 6100.6 6105.9 5610.7 5855.9 5873.6 5895.0 5901.4 5745.9 5879.8 5883.3 5893.6 5902.8 5580.3 5674.6 5747.2 5805.6 5828.5 5813.6 5854.3 5859.6 5873.1 5874.7 5603.8 5728.0 5740.6 5743.7 5752.9 15:21:20 INFO - PROCESS | 318 | 15:21:20 INFO - PROCESS | 318 | [#5] yui.html Cycles:180 Average:15518.22 Median:26183.84 stddev:19024.72 (72.7%) stddev-sans-first:19046.06 15:21:20 INFO - PROCESS | 318 | Values: 816.8 821.1 840.3 842.4 869.9 14298.5 14895.9 14908.8 15048.1 15097.6 13409.9 13633.3 13820.4 13897.5 13985.5 796.2 809.8 812.8 812.9 813.3 786.4 788.5 792.2 800.7 801.8 841.8 844.6 847.6 847.8 849.1 840.6 841.7 842.1 842.8 843.4 605.4 609.0 609.3 609.8 612.0 13247.9 13267.4 13381.8 13415.6 13418.0 11973.2 12109.0 12243.4 12250.3 12441.4 9936.7 11053.3 11125.3 11375.5 11646.2 4286.0 4291.6 4317.1 4349.4 4467.9 54685.5 55700.4 55838.2 60047.7 61239.0 11009.6 11141.0 11153.9 11205.4 11253.8 19055.0 19068.1 19081.6 19083.1 19155.6 8148.0 8227.0 8285.8 8366.3 8416.6 4646.7 4674.3 4711.0 4733.0 4900.3 3285.1 3355.9 3361.7 3362.7 3385.8 626.6 628.4 634.8 647.6 650.6 658.9 667.7 772.9 777.1 793.5 8897.6 9181.8 9308.9 9535.4 9634.2 766.1 772.8 791.9 799.5 804.4 4573.4 4588.6 4769.2 4820.9 4859.3 67397.3 68664.0 68968.7 69590.0 70934.3 59938.7 62158.4 62279.4 62899.4 63371.7 57018.4 57170.7 57479.4 58078.7 58788.4 8812.8 9095.9 9118.6 9139.5 9203.8 36653.0 36853.8 37257.8 37369.0 37667.4 45608.0 47598.5 49817.3 49837.3 50405.5 10634.5 11165.6 11340.6 11577.1 11688.9 12270.5 12899.0 12969.8 13343.7 13354.9 11651.4 12086.0 12364.1 12418.4 12591.0 11681.9 11791.8 11871.8 11964.9 12597.8 11120.3 11120.6 11190.7 11236.7 11832.3 9886.5 10194.5 10198.5 10203.4 10438.9 10141.7 10258.1 10286.0 10443.4 10464.4 15:21:20 INFO - PROCESS | 318 | -------- Summary: end -------- 15:21:20 INFO - PROCESS | 318 | 15:21:21 INFO - TEST-INFO | 318: exit 0 15:21:21 INFO - TEST-OK | dromaeo_css | took 1111158ms 15:21:21 INFO - TEST-START | kraken 15:21:21 INFO - operating with platform_type : linux_ 15:21:21 INFO - Initialising browser for kraken test... 15:21:21 INFO - TEST-INFO | started process 550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiPRN0b/profile http://localhost:40878/getInfo.html) 15:21:25 INFO - PROCESS | 550 | 15:21:25 INFO - PROCESS | 550 | (process:622): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:21:26 INFO - PROCESS | 550 | __metrics Screen width/height:1600/1200 15:21:26 INFO - PROCESS | 550 | colorDepth:24 15:21:26 INFO - PROCESS | 550 | Browser inner width/height: 1024/697 15:21:26 INFO - PROCESS | 550 | __metrics 15:21:26 ERROR - PROCESS | 550 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 15:21:27 INFO - TEST-INFO | 550: exit 0 15:21:27 INFO - Browser initialized. 15:21:27 INFO - Running cycle 1/1 for kraken test... 15:21:27 INFO - TEST-INFO | started process 673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiPRN0b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:29 INFO - PROCESS | 673 | 15:21:29 INFO - PROCESS | 673 | (process:738): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:21:39 INFO - PROCESS | 673 | RSS: Main: 166162432 15:21:39 INFO - PROCESS | 673 | 15:21:42 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40878/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:43 INFO - PROCESS | 673 | RSS: Main: 170688512 15:21:43 INFO - PROCESS | 673 | 15:21:45 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40878/tests/kraken/driver.html?testName=audio-dft) 15:21:46 INFO - PROCESS | 673 | RSS: Main: 170491904 15:21:46 INFO - PROCESS | 673 | 15:21:49 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40878/tests/kraken/driver.html?testName=audio-fft) 15:21:49 INFO - PROCESS | 673 | RSS: Main: 165326848 15:21:49 INFO - PROCESS | 673 | 15:21:52 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40878/tests/kraken/driver.html?testName=audio-oscillator) 15:21:52 INFO - PROCESS | 673 | RSS: Main: 165584896 15:21:52 INFO - PROCESS | 673 | 15:21:55 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40878/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:55 INFO - PROCESS | 673 | RSS: Main: 166039552 15:21:55 INFO - PROCESS | 673 | 15:21:58 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40878/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:59 INFO - PROCESS | 673 | RSS: Main: 166592512 15:21:59 INFO - PROCESS | 673 | 15:22:02 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40878/tests/kraken/driver.html?testName=imaging-desaturate) 15:22:03 INFO - PROCESS | 673 | RSS: Main: 164683776 15:22:03 INFO - PROCESS | 673 | 15:22:06 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40878/tests/kraken/driver.html?testName=json-parse-financial) 15:22:06 INFO - PROCESS | 673 | RSS: Main: 165756928 15:22:06 INFO - PROCESS | 673 | 15:22:08 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40878/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:22:09 INFO - PROCESS | 673 | RSS: Main: 166117376 15:22:09 INFO - PROCESS | 673 | 15:22:10 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40878/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:22:11 INFO - PROCESS | 673 | RSS: Main: 166195200 15:22:11 INFO - PROCESS | 673 | 15:22:13 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40878/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:22:14 INFO - PROCESS | 673 | RSS: Main: 166846464 15:22:14 INFO - PROCESS | 673 | 15:22:16 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:22:17 INFO - PROCESS | 673 | RSS: Main: 166649856 15:22:17 INFO - PROCESS | 673 | 15:22:20 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:22:20 INFO - PROCESS | 673 | RSS: Main: 166514688 15:22:20 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:40878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40878/tests/kraken/driver.html?testName=ai-astar) 15:22:22 INFO - PROCESS | 673 | RSS: Main: 168173568 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | __start_tp_report 15:22:22 INFO - PROCESS | 673 | _x_x_mozilla_page_load 15:22:22 INFO - PROCESS | 673 | _x_x_mozilla_page_load_details 15:22:22 INFO - PROCESS | 673 | |i|pagename|runs| 15:22:22 INFO - PROCESS | 673 | |0;ai-astar;112;106;111;111;111;109;112;110;113;111 15:22:22 INFO - PROCESS | 673 | |1;audio-beat-detection;165;125;163;174;127;161;160;127;207;129 15:22:22 INFO - PROCESS | 673 | |2;audio-dft;164;163;164;162;167;169;168;164;163;166 15:22:22 INFO - PROCESS | 673 | |3;audio-fft;78;76;74;150;76;75;76;75;158;79 15:22:22 INFO - PROCESS | 673 | |4;audio-oscillator;83;83;138;83;83;83;129;84;84;152 15:22:22 INFO - PROCESS | 673 | |5;imaging-gaussian-blur;117;117;118;118;119;119;118;117;118;118 15:22:22 INFO - PROCESS | 673 | |6;imaging-darkroom;148;149;147;148;150;149;147;147;149;150 15:22:22 INFO - PROCESS | 673 | |7;imaging-desaturate;98;96;96;96;96;97;97;97;96;96 15:22:22 INFO - PROCESS | 673 | |8;json-parse-financial;57;57;57;56;57;60;60;85;59;54 15:22:22 INFO - PROCESS | 673 | |9;json-stringify-tinderbox;61;60;62;62;63;62;62;62;61;62 15:22:22 INFO - PROCESS | 673 | |10;stanford-crypto-aes;84;79;79;80;88;80;81;86;81;83 15:22:22 INFO - PROCESS | 673 | |11;stanford-crypto-ccm;142;139;136;126;123;130;134;128;157;132 15:22:22 INFO - PROCESS | 673 | |12;stanford-crypto-pbkdf2;162;162;163;159;165;157;160;165;158;158 15:22:22 INFO - PROCESS | 673 | |13;stanford-crypto-sha256-iterative;67;62;61;64;65;61;62;64;64;62 15:22:22 INFO - PROCESS | 673 | __end_tp_report 15:22:22 INFO - PROCESS | 673 | __start_cc_report 15:22:22 INFO - PROCESS | 673 | _x_x_mozilla_cycle_collect,875 15:22:22 INFO - PROCESS | 673 | __end_cc_report 15:22:22 INFO - PROCESS | 673 | __startTimestamp1464214942765__endTimestamp 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | ------- Summary: start ------- 15:22:22 INFO - PROCESS | 673 | Number of tests: 14 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.96 (1.8%) stddev-sans-first:2.01 15:22:22 INFO - PROCESS | 673 | Values: 112.0 106.0 111.0 111.0 111.0 109.0 112.0 110.0 113.0 111.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:162.00 stddev:26.71 (16.5%) stddev-sans-first:28.02 15:22:22 INFO - PROCESS | 673 | Values: 165.0 125.0 163.0 174.0 127.0 161.0 160.0 127.0 207.0 129.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:2.36 (1.4%) stddev-sans-first:2.47 15:22:22 INFO - PROCESS | 673 | Values: 164.0 163.0 164.0 162.0 167.0 169.0 168.0 164.0 163.0 166.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#3] audio-fft Cycles:10 Average:91.70 Median:76.00 stddev:32.92 (43.3%) stddev-sans-first:34.54 15:22:22 INFO - PROCESS | 673 | Values: 78.0 76.0 74.0 150.0 76.0 75.0 76.0 75.0 158.0 79.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#4] audio-oscillator Cycles:10 Average:100.20 Median:83.00 stddev:27.78 (33.5%) stddev-sans-first:28.76 15:22:22 INFO - PROCESS | 673 | Values: 83.0 83.0 138.0 83.0 83.0 83.0 129.0 84.0 84.0 152.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 15:22:22 INFO - PROCESS | 673 | Values: 117.0 117.0 118.0 118.0 119.0 119.0 118.0 117.0 118.0 118.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:1.17 (0.8%) stddev-sans-first:1.24 15:22:22 INFO - PROCESS | 673 | Values: 148.0 149.0 147.0 148.0 150.0 149.0 147.0 147.0 149.0 150.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 15:22:22 INFO - PROCESS | 673 | Values: 98.0 96.0 96.0 96.0 96.0 97.0 97.0 97.0 96.0 96.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:58.00 stddev:8.90 (15.4%) stddev-sans-first:9.37 15:22:22 INFO - PROCESS | 673 | Values: 57.0 57.0 57.0 56.0 57.0 60.0 60.0 85.0 59.0 54.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 15:22:22 INFO - PROCESS | 673 | Values: 61.0 60.0 62.0 62.0 63.0 62.0 62.0 62.0 61.0 62.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:3.07 (3.7%) stddev-sans-first:3.18 15:22:22 INFO - PROCESS | 673 | Values: 84.0 79.0 79.0 80.0 88.0 80.0 81.0 86.0 81.0 83.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:135.00 stddev:9.76 (7.2%) stddev-sans-first:9.99 15:22:22 INFO - PROCESS | 673 | Values: 142.0 139.0 136.0 126.0 123.0 130.0 134.0 128.0 157.0 132.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:162.00 stddev:2.92 (1.8%) stddev-sans-first:3.07 15:22:22 INFO - PROCESS | 673 | Values: 162.0 162.0 163.0 159.0 165.0 157.0 160.0 165.0 158.0 158.0 15:22:22 INFO - PROCESS | 673 | 15:22:22 INFO - PROCESS | 673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:64.00 stddev:1.93 (3.0%) stddev-sans-first:1.48 15:22:22 INFO - PROCESS | 673 | Values: 67.0 62.0 61.0 64.0 65.0 61.0 62.0 64.0 64.0 62.0 15:22:22 INFO - PROCESS | 673 | -------- Summary: end -------- 15:22:22 INFO - PROCESS | 673 | 15:22:23 INFO - TEST-INFO | 673: exit 0 15:22:23 INFO - TEST-OK | kraken | took 62252ms 15:22:23 INFO - SUITE-END | took 1173s 15:22:23 INFO - Completed test suite (00:19:33) 15:22:23 INFO - javascript benchmark 15:22:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7105.472377210921, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.782735208535, 3141.968580314196, 3156.321390900956, 3178.6185657721076, 3199.120241933468, 5373.220882971972, 5389.703566303851, 5424.159255315422, 5429.267048948391, 5605.859853503664, 5344.599155063376, 5350.491703288181, 5353.812616558421, 5383.650062745919, 5405.837824865261, 4853.902921941568, 4969.527894849984, 5077.060743762398, 5086.084504789136, 5141.691498510101, 5087.669301495391, 5191.818286359978, 5193.58451323895, 5196.3764348278255, 5262.684238945675, 4969.329140566031, 5092.84721458355, 5149.124648809711, 5163.509466600685, 5164.302819119408, 5041.798328066873, 5050.217216331474, 5056.393232812049, 5059.87350316245, 5095.949040509585, 5077.593792496591, 5118.513741194581, 5122.564582010534, 5131.717755523445, 5138.845834624967, 5347.732613369355, 5358.196270559447, 5380.354357477088, 5419.945800541984, 5456.563474922036, 5903.409659034105, 5924.052151655757, 5931.288245410578, 5939.0, 5948.31594366649, 5952.345242023374, 5964.493018093423, 5968.97015514924, 5975.073863551156, 5982.312034116046, 5316.734163291859, 5524.171374293848, 5562.582806289504, 5606.495415412592, 5662.5753068520025, 6137.232845894263, 6154.261488621394, 6165.229346331708, 6169.413905678954, 6194.38056194386, 5692.715364231772, 5817.447342502455, 5883.882322353529, 5916.437938395846, 5918.822435326947, 5906.49794767441, 5918.46733793952, 6008.489278411384, 6060.727267272983, 6069.908951365733, 5963.970180149072, 5990.790322338785, 6022.277326720821, 6025.9096113558335, 6040.365761595057, 5739.081746920473, 5792.275965504312, 5994.970025149846, 6022.909656355158, 6061.090836374491, 4351.216780979454, 4435.844745433894, 4442.444694413199, 4484.798184081724, 4497.977510112429, 3996.7801770902297, 4038.3336749436603, 4048.8987775305263, 4071.959280407217, 4098.877033688994, 5621.241132447149, 5645.294338207724, 5798.333191682926, 5803.47768700819, 5815.73829177688, 6000.459958603747, 6024.64445499759, 6025.9397406026255, 6026.969865150646, 6108.175396321529, 5673.631213971161, 5709.0865461525955, 5728.198052272685, 5737.971310143423, 5742.7415766290615, 5049.697018178921, 5051.26756620288, 5091.592672586258, 5129.820456284012, 5160.974195129001, 6160.199174107427, 6167.938320616826, 6177.011678131477, 6182.845428864314, 6184.165137706442, 5962.423789971383, 5996.850078748066, 5997.400259973968, 6006.279246490449, 6031.5476339273855, 6072.301685306246, 6102.694865256808, 6108.541859360477, 6111.9816929085955, 6160.229971253593, 5797.9420205797405, 5808.6224395414165, 5850.414958504116, 5911.172435859069, 5953.255843019622, 5883.29400471929, 5943.881122377442, 5958.940410596012, 5995.760169593167, 6059.21230240066, 5678.858028549319, 5712.228849105318, 5736.053551164178, 5750.137479378127, 5793.507551858139, 5766.913496297643, 5791.536677065909, 5803.100519419497, 5823.82528524145, 5830.300363956352, 5531.0873705838085, 5672.03575392176, 5715.971420143039, 5721.342045664802, 5723.7996670116345, 5688.601797874109, 5743.511801496919, 5759.337676167294, 5787.739551720267, 5805.593608447368, 5616.915746263891, 5706.229658996149, 5707.914381284367, 5713.542916566747, 5803.709814509173], "value": 5473.476366540223, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.7506247376101, 646.7413034786082, 653.408665158032, 657.8388294867758, 669.5179470781039, 38496.80751596241, 42338.57661423385, 42378.36432453508, 42844.571554284485, 43156.136877262514, 42821.35767963483, 43219.0, 43408.0, 43768.78115609426, 43900.56099439005, 8615.870761938577, 8722.607482663263, 8725.476471411705, 8753.474791512497, 8778.473291602524, 8593.742187734379, 8713.085126061767, 8716.041235464094, 8718.564071796416, 8726.258268047224, 8714.172153645393, 8733.34499912506, 8734.825303493926, 8773.429727067753, 8776.341774366949, 8580.957095214515, 8690.130986901322, 8699.043105258417, 8702.912970870273, 8717.259032982203, 8610.0, 8645.783855403603, 8668.219860212548, 8705.0, 8713.4336268143, 32201.838990804896, 40451.7977410114, 40778.38832417516, 40992.0, 41136.0, 3355.6644335566493, 3437.7765445245977, 3848.2111167210655, 4149.605787450188, 4297.656187504992, 31358.0, 31532.36935261305, 32252.516212256836, 32720.0, 32806.34387312264, 3840.2511510255513, 3899.161680238734, 3915.275674000319, 3961.524617045944, 4104.076582768883, 294888.1022379562, 296818.0, 297135.0, 297961.51019244984, 298541.0, 34180.658193417745, 34757.30485390328, 35016.0, 35204.0, 35386.0, 36920.44619330712, 37159.071023224096, 37211.81394093066, 37263.25473490515, 37318.62681373206, 14945.626359340886, 15236.085834849944, 15249.6187595311, 15253.08481491114, 15289.08265504051, 12399.132060755841, 12554.121211515107, 12568.560100396442, 12596.055295852664, 12602.621921342374, 8263.917360826435, 8368.0, 8371.706990255312, 8405.663773448994, 8413.915860841436, 3241.789283696552, 3241.8054916705073, 3254.332861763333, 3286.704196622268, 3317.0712200583876, 1044.4464433850071, 1054.7943151085617, 1082.832161015044, 1083.0685610375072, 1160.2458402038742, 32972.3405531888, 33245.1205767425, 33371.16572085717, 33467.64114818177, 33751.66248337485, 1100.8568886044764, 1108.1910205549993, 1130.2822707580744, 1177.2053863642006, 1181.988180118205, 16606.335746570003, 16845.831541684427, 16938.0, 16983.91508042452, 17203.569910752332, 544742.0, 551485.0, 554538.0, 554768.0, 555136.0, 58748.4125158743, 58806.41193588095, 59089.0, 59243.40756592465, 59279.0, 1343.9664008399868, 1394.8186735724291, 1395.483671041721, 1402.8246469191351, 1404.9297535123203, 30187.69812301849, 31451.685483144876, 31642.683573163973, 31708.682913170574, 32264.193395165308, 51034.74482627563, 54207.0, 55994.44005559892, 56325.71837140788, 62109.689451552455, 462486.0, 465911.0, 466474.0, 467505.0, 470558.0, 44682.77658611686, 44865.0, 45202.54797451983, 45266.54733452755, 46292.07415851732, 49599.0, 49627.75186124046, 50351.74824125856, 50795.74602126966, 50988.0, 41598.0, 41685.58314416817, 42955.7852210737, 43727.469538565994, 44398.55601443944, 41860.372094418, 42470.5752942479, 42542.0, 42985.140297193255, 43211.35182972195, 42341.0, 42713.78643106889, 43645.0, 43949.56050439455, 44015.77992110019, 36051.45922811212, 37574.24851503009, 37590.812045939594, 38141.80929095448, 38195.809020954715, 28246.610406751322, 29208.853955730086, 29234.853825730734, 29259.0, 29374.118776435887], "value": 19024.10366509949, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.2956677979636, 392.174472734893, 393.264595206963, 401.8734098758891, 422.3896469601425, 13728.244946527937, 18392.540186495327, 18739.718904216414, 19690.11394487248, 19845.0, 18394.724079138825, 18629.44111676652, 18944.336948206816, 19601.607967840635, 19651.31220407286, 5655.349634792, 5719.828405147852, 5813.215215945836, 5829.0964900440285, 5835.854103647401, 5358.2498450217, 5644.971775141139, 5739.512141467981, 5760.0, 5807.30312362515, 5679.801206957757, 5684.261046064006, 5688.345840228385, 5704.172894930232, 5706.258186435757, 5626.578006649497, 5667.716614169296, 5671.829845104653, 5696.51579615731, 5755.280589926259, 5387.488188622075, 5443.0, 5497.587680923947, 5514.035043867348, 5517.44825517445, 12122.636320910387, 19947.9028653424, 20934.790652093438, 22367.440813979618, 22445.551088978293, 2119.3853782403085, 2239.6749498302806, 2256.9322920312416, 2544.109561653425, 2827.377976845091, 9095.499747513884, 9326.766830829216, 9607.807843843084, 9804.558794854178, 13965.860341396557, 1881.5578339090303, 1885.792562818089, 1890.4234208566381, 1899.943001709951, 1981.1382048808814, 74939.0, 80362.0, 81024.78462823121, 82216.0, 82259.0, 10454.634087807042, 10647.361158330525, 10682.679519614425, 10707.0, 11081.833772493419, 14918.850811491746, 15018.0, 15042.0, 15101.169435680924, 15162.620934476727, 7420.5547667140145, 7710.113336966208, 7870.606469676608, 7940.1662825403655, 7947.682092716343, 7274.59989700561, 7298.270172982766, 7300.452466065067, 7528.924710752823, 7588.241175882367, 4567.36056952027, 4602.286645569942, 4671.743054131987, 4684.110019096361, 4700.623950083985, 1750.614864729783, 1954.7947465515915, 1985.8808471491757, 2000.479875232421, 2032.6950957356514, 912.1516989200107, 987.4766373821886, 1001.1990407673832, 1056.1603525197334, 1117.435694974033, 18359.724604130948, 18697.532561685795, 19022.809771902103, 19453.902730486257, 19616.411507654793, 995.4326034160604, 1030.4281123976266, 1030.685640879524, 1064.8455973883742, 1075.1882328841675, 9732.172765315028, 10883.583216588659, 10914.890851091388, 10922.890771092347, 11026.117910567136, 416964.0, 435506.0, 441428.0, 444624.0, 447202.0, 85947.57026214829, 87484.1251587476, 87710.0, 88285.55857220673, 89617.0, 1012.1649639047815, 1019.6940917724653, 1041.890601486848, 1068.7915856407926, 1073.7154654016692, 16797.41209057726, 17142.571435713708, 17211.225494853014, 17366.21852016637, 17523.56191095233, 39286.41070384004, 39970.40044399278, 41488.585114148475, 41650.791746041075, 41885.58114418817, 56031.15953260786, 57033.0, 58458.415415845295, 58475.70762146162, 58931.705341474735, 7638.770836874903, 7868.0, 7908.044149934873, 8124.675012999413, 8318.334533237448, 12250.387480626112, 12648.557300494438, 12703.618891433272, 12760.0, 12917.28954907489, 11090.556377745123, 11323.660290191307, 11389.145814063813, 11460.598879039193, 11497.712557186138, 10848.837267440837, 10971.561137554409, 10984.670459886216, 10989.120870330515, 11098.778024439627, 11362.55705023424, 11412.885871141183, 11424.371659558805, 11466.82799758021, 11617.88382116168, 7517.661705223388, 7591.734289299848, 7658.846823063619, 7876.56678882667, 8337.916620833714, 7801.0, 10498.0, 11037.503312351124, 11077.446127693744, 11090.390028548507], "value": 8972.469707811371, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.6313653154975, 1532.210911380639, 1645.6050547868515, 1804.0618878183336, 1808.3580328983203, 7997.280244777969, 8539.103394143618, 8616.224539791418, 9240.0, 9260.0, 8674.219320261176, 8924.375293729441, 8979.191872731453, 8988.505632190227, 8994.820103597924, 2264.094362255095, 2278.1456953642382, 2286.119843860109, 2290.278562252885, 2292.6446400807818, 2225.4992626658955, 2259.197984715427, 2289.381866895937, 2297.5519773644146, 2306.746257911628, 2229.1863469833474, 2247.8538894971857, 2257.4243567890167, 2272.125231785766, 2287.0, 2202.526456811785, 2206.3380985704225, 2215.8559693619945, 2233.1848875160613, 2237.451824303048, 2187.9671804922937, 2204.7574766775642, 2211.2150186683816, 2226.7216597925258, 2230.397792596006, 8836.0, 8878.334124940655, 8922.910770892338, 8926.821463570757, 8942.463452192824, 5114.744262786846, 5211.661242019294, 5224.399194092652, 5230.08473517133, 5239.895202095975, 3130.4052230076213, 3175.42842288388, 3314.254292784128, 3320.286138480214, 3332.41682705528, 1096.3915027159924, 1142.457332766929, 1146.2606618730872, 1148.2306854407484, 1174.424531979324, 12358.75282494354, 12448.377581120998, 12458.12793104483, 12495.75008499834, 12529.561465348761, 4352.564743525622, 4502.57225563571, 4520.977395113069, 4529.54704529551, 4546.909061818745, 10362.171026317876, 10429.37423754562, 10433.686989390331, 10461.110805581458, 10516.68449946503, 5167.328247327823, 5188.403333616607, 5192.169252919591, 5232.947670523246, 5244.265802787613, 4335.9349609755245, 4664.580187783115, 4806.134895718804, 4854.8786280342565, 4894.877628059327, 3956.1494278729638, 3986.940195897064, 4029.7783621901076, 4062.370332598452, 4087.6729861611, 1206.7164216409137, 1223.804191329383, 1229.5450683247257, 1237.424597562138, 1238.3468070126303, 1008.8991100889999, 1008.9899101009042, 1037.4501514197486, 1040.9323393979366, 1049.2497864027257, 6132.0, 6223.377662233831, 6332.715027823759, 6371.872562548723, 6417.903731444032, 432.27809558038155, 435.86923922823024, 439.32344189947764, 442.5861819199059, 449.3327408797932, 4309.396684464177, 4364.214441400578, 4396.4284642996845, 4401.405810215644, 4424.845130420485, 11059.336439813636, 11283.210175287652, 11342.659720208407, 11379.601713939972, 11415.0, 10982.395968221825, 11138.554457821758, 11254.0, 11283.717907052389, 11313.83029254562, 8173.060098088677, 8326.084130745614, 8382.245597896097, 8453.70412035588, 8501.852249946302, 6069.119977603311, 6103.786367477117, 6119.969400153149, 6177.96911015442, 6233.0, 10241.795164096826, 10280.537375817956, 10347.84478232812, 10350.016748408889, 10436.94781526118, 10202.540885660312, 10526.210534210119, 10548.085840826578, 10650.360978341325, 10702.464876756287, 7084.25615310385, 7643.694252229849, 7892.092409372766, 7901.17037711055, 8026.8795968061695, 8802.38383313162, 8802.427842190236, 8831.64673413082, 8917.0, 8932.821343573221, 7600.619969001638, 7740.109887363025, 7775.261350171724, 7834.804129896798, 8070.1122876484715, 7692.846143076995, 7859.17478664732, 7860.9213907860185, 7893.842123157619, 7898.091719452336, 6987.161540615159, 7006.229314775473, 7015.473839461959, 7036.155661320674, 7046.682899269443, 5220.504052115043, 5372.731363431891, 5499.120140777456, 5516.0071187186695, 5644.181593668977, 5293.550048245942, 5301.575873930154, 5304.893902122013, 5335.786568537215, 5413.215083812746], "value": 4592.605999920268, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.4498540164201, 314.06408901473594, 314.1235951694772, 332.64573229510574, 332.96337402885683, 5615.971920140393, 5624.481390024691, 5636.351819540754, 5649.548036157108, 5650.660960342382, 5507.54914063242, 5532.972335138329, 5551.555875529958, 5573.08044172712, 5603.663780173182, 4150.418941348214, 4190.308599081148, 4276.572342765714, 4288.785560721967, 4329.19909816685, 4267.957320426803, 4306.160298741746, 4310.224159651261, 4327.826886924519, 4331.678837954422, 4238.470191226097, 4267.530571637118, 4284.935725964113, 4288.463942007249, 4305.375720520523, 4032.2741906456827, 4252.2345977724, 4266.210751011073, 4295.871123866289, 4333.198358303724, 3671.3391589513876, 3706.9629303707156, 3722.1253005543676, 3726.2547490502006, 3730.7201959852846, 5339.733013349317, 5347.438518955492, 5348.91976620351, 5364.704941228231, 5393.649412788156, 4603.171429142753, 4879.414470263591, 4896.3145159677315, 4904.877378065541, 4915.066137433876, 5688.4311568843195, 5756.971215143939, 5756.971215143939, 5762.711864406763, 5858.619189752695, 4072.328065869128, 4081.9386209963777, 4153.54311025787, 4163.3130533461945, 4182.53611236068, 5979.970100149515, 6059.757609695607, 6078.149059131725, 6085.57400981927, 6087.934611443024, 4081.6326530611796, 4083.816228269735, 4102.569230230843, 4119.505659320841, 4131.194417088639, 4104.876853694334, 4141.8964525886495, 4155.8337666493, 4195.790210489463, 4233.936490952638, 4690.061987602493, 4851.927221091686, 4874.439439464436, 4906.969536397325, 4951.158303088484, 5751.22358481608, 5812.651240925558, 5815.563832712563, 5834.795782147605, 5850.619709718854, 1443.7256921184942, 1450.2966061460183, 1460.3793387810351, 1463.3853781411833, 1480.267267702494, 936.5176933879058, 941.9340646154703, 958.4680502321279, 959.2565761534727, 981.5975450065439, 5532.197831314437, 5541.445855414507, 5541.501264886179, 5617.943820561742, 5633.859153521113, 5856.677882716406, 5947.82156535296, 5953.166556682068, 5959.791407300723, 5999.310079340931, 5297.470252974672, 5643.322801263875, 5652.604317697722, 5654.491095801398, 5671.319441667027, 3170.3183815479783, 3174.952375714366, 3177.5710279112486, 3208.6149662040702, 3228.4027454920447, 5957.940420595825, 6092.0, 6211.782587609412, 6226.968865155736, 6251.9687401562705, 6037.63774173551, 6038.18484504595, 6062.333143354227, 6091.208142941389, 6118.296395914527, 6095.390460953958, 6183.3923179973535, 6204.565680402328, 6211.16149319845, 6222.284437289679, 5647.632903861236, 5901.675407852609, 5912.231409916683, 5933.703314834327, 5953.958057340034, 5828.94171058301, 5841.32824725162, 5854.092615644582, 5857.677827719516, 5867.647941123546, 5945.910811337747, 6096.177016102769, 6115.724792384264, 6205.689715514116, 6229.221347331583, 4140.4617399737845, 4150.730202536825, 4166.68749843769, 4172.520160181618, 4172.915042089018, 5929.377415371324, 6070.7875224366935, 6100.0, 6100.633961962297, 6105.877882442237, 5610.747516361856, 5855.94144058554, 5873.588848780544, 5895.02732049207, 5901.380355062828, 5745.942540574708, 5879.764809407576, 5883.323417807007, 5893.557983151195, 5902.763889444374, 5580.330360356783, 5674.602777805679, 5747.166660834072, 5805.593608447368, 5828.504577110823, 5813.6221145625395, 5854.268216472941, 5859.589828711949, 5873.148393483007, 5874.706264686834, 5603.80386686464, 5727.971360143172, 5740.569457290803, 5743.6840973745175, 5752.942470575241], "value": 4400.528381560194, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.8366326734654, 821.0803899632413, 840.252175563748, 842.3555979675549, 869.934754893383, 14298.499552515665, 14895.92552037241, 14908.776368354456, 15048.097114173157, 15097.62255943602, 13409.932950335235, 13633.318334083306, 13820.447182112703, 13897.513587024456, 13985.510507132252, 796.1719811396156, 809.7935026568247, 812.7642983534797, 812.9105798362175, 813.324940299553, 786.3512602103259, 788.4796034617153, 792.18405042806, 800.7037396163428, 801.7875263055295, 841.7937605286713, 844.5777111444278, 847.6439895244013, 847.7668641123679, 849.1169184048582, 840.6217202259008, 841.6549214821924, 842.1031601344548, 842.7893026743315, 843.4180415513276, 605.4036773777825, 608.9725962331705, 609.3114780298234, 609.838392825897, 611.9627231842029, 13247.867521324855, 13267.402966866417, 13381.799273010913, 13415.597532074053, 13418.0, 11973.221740586834, 12109.03127749778, 12243.449044793006, 12250.326232057234, 12441.440135193938, 9936.701898943043, 11053.28153670017, 11125.276857004268, 11375.544978200945, 11646.184767066308, 4285.9785701071605, 4291.570842915715, 4317.071829556629, 4349.391085248068, 4467.888302792456, 54685.45314546843, 55700.44299557034, 55838.20808959576, 60047.69976150091, 61239.0, 11009.637766573971, 11141.0, 11153.888461115448, 11205.383703896365, 11253.774924501464, 19055.047247637838, 19068.14193361302, 19081.61836763257, 19083.141258643394, 19155.61688766217, 8147.959260203661, 8227.0, 8285.751427457186, 8366.330693544502, 8416.621252043673, 4646.697964632288, 4674.322223277606, 4710.9764451177525, 4733.0, 4900.26496025599, 3285.14586207583, 3355.8825441109443, 3361.714254288413, 3362.69735723786, 3385.7629965902643, 626.5582764151262, 628.3622123544606, 634.7936920500763, 647.6405594894878, 650.6291413894035, 658.887989041864, 667.7028722218663, 772.8664427335723, 777.0869228656419, 793.5318162284279, 8897.599608017656, 9181.770455738526, 9308.8603670945, 9535.427874327563, 9634.181094607036, 766.1074847802248, 772.7681695491331, 791.8930944322558, 799.4763429953274, 804.3565147881789, 4573.405457290531, 4588.564086411786, 4769.165396055676, 4820.855374338776, 4859.2954021666665, 67397.3260267391, 68664.0, 68968.6551567239, 69590.0, 70934.2906570938, 59938.70030649819, 62158.37841621616, 62279.377206228266, 62899.37100629027, 63371.683141584, 57018.42981570214, 57170.71414642983, 57479.425205748244, 58078.709606451695, 58788.35452404652, 8812.779680508038, 9095.909040909772, 9118.635254589743, 9139.497327647043, 9203.815923681623, 36653.0, 36853.815730921175, 37257.813710931274, 37369.0, 37667.43498847465, 45608.0, 47598.52401475941, 49817.25274120964, 49837.252441214136, 50405.49594504008, 10634.468276585985, 11165.609203677832, 11340.6030788922, 11577.07383409342, 11688.88311116878, 12270.509179632714, 12899.0, 12969.805452918024, 13343.733125337245, 13354.93322533381, 11651.41742912868, 12085.978505373656, 12364.072694547765, 12418.447694038245, 12591.0, 11681.88318116808, 11791.823122652995, 11871.821922670993, 11964.940175299067, 12597.811032834332, 11120.332780033224, 11120.61077862271, 11190.720231994264, 11236.66290011301, 11832.290062596272, 9886.4562449066, 10194.541245643815, 10198.490075496344, 10203.38779673222, 10438.895611044096, 10141.695749127539, 10258.076773090457, 10286.0, 10443.425611591132, 10464.372137671764], "value": 6815.119039029654, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 111.0, 111.0, 109.0, 112.0, 110.0, 113.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 125.0, 163.0, 174.0, 127.0, 161.0, 160.0, 127.0, 207.0, 129.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 162.0, 167.0, 169.0, 168.0, 164.0, 163.0, 166.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 74.0, 150.0, 76.0, 75.0, 76.0, 75.0, 158.0, 79.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 138.0, 83.0, 83.0, 83.0, 129.0, 84.0, 84.0, 152.0], "value": 100.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 119.0, 119.0, 118.0, 117.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 148.0, 150.0, 149.0, 147.0, 147.0, 149.0, 150.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 57.0, 60.0, 60.0, 85.0, 59.0, 54.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 79.0, 80.0, 88.0, 80.0, 81.0, 86.0, 81.0, 83.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 136.0, 126.0, 123.0, 130.0, 134.0, 128.0, 157.0, 132.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 159.0, 165.0, 157.0, 160.0, 165.0, 158.0, 158.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 61.0, 64.0, 65.0, 61.0, 62.0, 64.0, 64.0, 62.0], "value": 63.2, "unit": "score"}]}]} 15:22:23 INFO - Return code: 0 15:22:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:22:24 ERROR - # TBPL SUCCESS # 15:22:24 INFO - Running post-action listener: _resource_record_post_action 15:22:24 INFO - ##### 15:22:24 INFO - ##### Finished run-tests step (success) 15:22:24 INFO - ##### 15:22:24 INFO - Running post-run listener: _resource_record_post_run 15:22:24 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405020672; Read time: 16; Write time: 416732 15:22:24 INFO - TinderboxPrint: CPU usage
13.5% 15:22:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:22:24 INFO - TinderboxPrint: I/O write bytes / time
405,020,672 / 416,732 15:22:24 INFO - TinderboxPrint: CPU idle
8,222.5 (86.5%) 15:22:24 INFO - TinderboxPrint: CPU user
1,222.0 (12.9%) 15:22:24 INFO - TinderboxPrint: Swap in / out
0 / 0 15:22:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114401280; Read time: 0; Write time: 119132 15:22:24 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290619392; Read time: 16; Write time: 297600 15:22:24 INFO - Running post-run listener: _upload_blobber_files 15:22:24 INFO - Blob upload gear active. 15:22:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:22:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:22:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:22:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:22:25 INFO - (blobuploader) - INFO - Open directory for files ... 15:22:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:22:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:22:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:26 INFO - (blobuploader) - INFO - Done attempting. 15:22:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:22:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:22:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:32 INFO - (blobuploader) - INFO - Done attempting. 15:22:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:22:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:33 INFO - (blobuploader) - INFO - Done attempting. 15:22:33 INFO - (blobuploader) - INFO - Iteration through files over. 15:22:33 INFO - Return code: 0 15:22:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:22:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:22:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/30e8e0ee77b9d411f516d6ac3b3082e21be009c0f9317d32262ef2298115748371fcf078082932824d6c831ce79af4cd3c7931e0641dcff0f4c754c5a0ef45bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/7b943336fa4606a82713ad97819bb3065cc13fa62dad7cb46b83c4513727c44bbdf08789ed8a3adf73091d063dd296885b2cab412277c4ee557a58b48f9ac101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/dd8aa9765c1a7722bcc11766a851621c1e45ce8aff76366b25411ba842d21f7be8579c604196ef490fa4cc7cd2abbc0e87825495966a7a707b3e35130005659a"} 15:22:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:22:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:22:33 INFO - Contents: 15:22:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/30e8e0ee77b9d411f516d6ac3b3082e21be009c0f9317d32262ef2298115748371fcf078082932824d6c831ce79af4cd3c7931e0641dcff0f4c754c5a0ef45bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/7b943336fa4606a82713ad97819bb3065cc13fa62dad7cb46b83c4513727c44bbdf08789ed8a3adf73091d063dd296885b2cab412277c4ee557a58b48f9ac101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/dd8aa9765c1a7722bcc11766a851621c1e45ce8aff76366b25411ba842d21f7be8579c604196ef490fa4cc7cd2abbc0e87825495966a7a707b3e35130005659a"} 15:22:33 INFO - Running post-run listener: copy_logs_to_upload_dir 15:22:33 INFO - Copying logs to upload dir... 15:22:33 INFO - mkdir: /builds/slave/test/build/upload/logs 15:22:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.670950 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-25 15:22:32.867941) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 15:22:32.872099) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1464213712.181084-28367724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/30e8e0ee77b9d411f516d6ac3b3082e21be009c0f9317d32262ef2298115748371fcf078082932824d6c831ce79af4cd3c7931e0641dcff0f4c754c5a0ef45bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/7b943336fa4606a82713ad97819bb3065cc13fa62dad7cb46b83c4513727c44bbdf08789ed8a3adf73091d063dd296885b2cab412277c4ee557a58b48f9ac101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/dd8aa9765c1a7722bcc11766a851621c1e45ce8aff76366b25411ba842d21f7be8579c604196ef490fa4cc7cd2abbc0e87825495966a7a707b3e35130005659a"} build_url:https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/JF8qGnrCShuPzaRcokR2pA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/30e8e0ee77b9d411f516d6ac3b3082e21be009c0f9317d32262ef2298115748371fcf078082932824d6c831ce79af4cd3c7931e0641dcff0f4c754c5a0ef45bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/7b943336fa4606a82713ad97819bb3065cc13fa62dad7cb46b83c4513727c44bbdf08789ed8a3adf73091d063dd296885b2cab412277c4ee557a58b48f9ac101", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/dd8aa9765c1a7722bcc11766a851621c1e45ce8aff76366b25411ba842d21f7be8579c604196ef490fa4cc7cd2abbc0e87825495966a7a707b3e35130005659a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 15:22:32.898018) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 15:22:32.898364) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1464213712.181084-28367724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 15:22:32.983400) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 15:22:32.983739) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 15:22:32.984020) ========= ========= Total master_lag: 0.15 =========