builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1469469720.78 results: success (0) buildid: 20160725083025 builduid: 41804f40331f41dcbc6d15a591a9b06e revision: 63c2b8192228dee0139431eded5b92a9db126de2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:00.784429) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:00.784926) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:00.785213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:00.800798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:00.801239) ========= 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=ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 11:02:01-- 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% 220M=0s 2016-07-25 11:02:01 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110131 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:00.925775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:00.926098) ========= 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=ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018692 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:00.993776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:00.994157) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 63c2b8192228dee0139431eded5b92a9db126de2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 63c2b8192228dee0139431eded5b92a9db126de2 --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=ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 11:02:01,363 truncating revision to first 12 chars 2016-07-25 11:02:01,363 Setting DEBUG logging. 2016-07-25 11:02:01,363 attempt 1/10 2016-07-25 11:02:01,363 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/63c2b8192228?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 11:02:01,691 unpacking tar archive at: fx-team-63c2b8192228/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658684 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:01.719223) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:01.719572) ========= script_repo_revision: 63c2b8192228dee0139431eded5b92a9db126de2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:01.719978) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:01.720270) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 11:02:01.731536) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-25 11:02:01.731947) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:02:02 INFO - MultiFileLogger online at 20160725 11:02:02 in /builds/slave/test 11:02:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:02:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:02:02 INFO - {'append_to_log': False, 11:02:02 INFO - 'base_work_dir': '/builds/slave/test', 11:02:02 INFO - 'blob_upload_branch': 'Fx-Team', 11:02:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:02:02 INFO - 'branch': 'Fx-Team', 11:02:02 INFO - 'buildbot_json_path': 'buildprops.json', 11:02:02 INFO - 'config_files': ('talos/linux_config.py',), 11:02:02 INFO - 'default_actions': ('clobber', 11:02:02 INFO - 'read-buildbot-config', 11:02:02 INFO - 'download-and-extract', 11:02:02 INFO - 'populate-webroot', 11:02:02 INFO - 'create-virtualenv', 11:02:02 INFO - 'install', 11:02:02 INFO - 'run-tests'), 11:02:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:02:02 INFO - 'download_minidump_stackwalk': True, 11:02:02 INFO - 'download_symbols': 'ondemand', 11:02:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:02:02 INFO - 'tooltool.py': '/tools/tooltool.py', 11:02:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:02:02 INFO - '/tools/misc-python/virtualenv.py')}, 11:02:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:02:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:02:02 INFO - 'installer_path': 'installer.exe', 11:02:02 INFO - 'log_level': 'info', 11:02:02 INFO - 'log_name': 'talos', 11:02:02 INFO - 'log_to_console': True, 11:02:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:02:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:02:02 INFO - 'opt_config_files': (), 11:02:02 INFO - 'pip_index': False, 11:02:02 INFO - 'sps_profile': False, 11:02:02 INFO - 'sps_profile_interval': 0, 11:02:02 INFO - 'suite': 'dromaeojs', 11:02:02 INFO - 'system_bits': '32', 11:02:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:02:02 INFO - 'title': 'talos-linux64-ix-035', 11:02:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:02:02 INFO - 'use_talos_json': True, 11:02:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:02:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:02:02 INFO - 'work_dir': 'build'} 11:02:02 INFO - [mozharness: 2016-07-25 18:02:02.193492Z] Running clobber step. 11:02:02 INFO - Running pre-action listener: _resource_record_pre_action 11:02:02 INFO - Running main action method: clobber 11:02:02 INFO - rmtree: /builds/slave/test/build 11:02:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:02:03 INFO - Running post-action listener: _resource_record_post_action 11:02:03 INFO - [mozharness: 2016-07-25 18:02:03.190814Z] Finished clobber step (success) 11:02:03 INFO - [mozharness: 2016-07-25 18:02:03.190914Z] Running read-buildbot-config step. 11:02:03 INFO - Running pre-action listener: _resource_record_pre_action 11:02:03 INFO - Running main action method: read_buildbot_config 11:02:03 INFO - Using buildbot properties: 11:02:03 INFO - { 11:02:03 INFO - "project": "", 11:02:03 INFO - "product": "firefox", 11:02:03 INFO - "script_repo_revision": "production", 11:02:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:02:03 INFO - "repository": "", 11:02:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:02:03 INFO - "buildid": "20160725083025", 11:02:03 INFO - "pgo_build": "True", 11:02:03 INFO - "basedir": "/builds/slave/test", 11:02:03 INFO - "buildnumber": 315, 11:02:03 INFO - "slavename": "talos-linux64-ix-035", 11:02:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:02:03 INFO - "platform": "ubuntu64_hw", 11:02:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:02:03 INFO - "branch": "fx-team", 11:02:03 INFO - "repo_path": "integration/fx-team", 11:02:03 INFO - "revision": "63c2b8192228dee0139431eded5b92a9db126de2", 11:02:03 INFO - "stage_platform": "linux64-pgo", 11:02:03 INFO - "builduid": "41804f40331f41dcbc6d15a591a9b06e", 11:02:03 INFO - "slavebuilddir": "test" 11:02:03 INFO - } 11:02:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:02:03 INFO - Running post-action listener: _resource_record_post_action 11:02:03 INFO - [mozharness: 2016-07-25 18:02:03.193352Z] Finished read-buildbot-config step (success) 11:02:03 INFO - [mozharness: 2016-07-25 18:02:03.193442Z] Running download-and-extract step. 11:02:03 INFO - Running pre-action listener: _resource_record_pre_action 11:02:03 INFO - Running main action method: download_and_extract 11:02:03 INFO - mkdir: /builds/slave/test/build/tests 11:02:03 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')]} 11:02:03 INFO - https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:02:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:02:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:02:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:02:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:02:07 INFO - Downloaded 1361 bytes. 11:02:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:02:07 INFO - Using the following test package requirements: 11:02:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:02:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:02:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:02:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:07 INFO - u'jsshell-linux-x86_64.zip'], 11:02:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:02:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:02:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:02:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:02:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:02:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:02:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:02:07 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')]} 11:02:07 INFO - https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:02:15 INFO - Downloaded 24311979 bytes. 11:02:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:02:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:02:16 INFO - Return code: 0 11:02:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:02:16 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')]} 11:02:16 INFO - https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:02:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:02:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:02:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:02:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:02:21 INFO - Downloaded 24311979 bytes. 11:02:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:02:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:02:23 INFO - Return code: 0 11:02:23 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')]} 11:02:23 INFO - https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:02:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:02:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:02:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:02:24 INFO - Downloaded 14403248 bytes. 11:02:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:02:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:02:24 INFO - Return code: 0 11:02:24 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')]} 11:02:24 INFO - https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:02:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:02:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:02:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:02:25 INFO - Downloaded 60890250 bytes. 11:02:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:02:25 INFO - mkdir: /builds/slave/test/properties 11:02:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:02:25 INFO - Writing to file /builds/slave/test/properties/build_url 11:02:25 INFO - Contents: 11:02:25 INFO - build_url:https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:02:26 INFO - Running post-action listener: _resource_record_post_action 11:02:26 INFO - Running post-action listener: set_extra_try_arguments 11:02:26 INFO - [mozharness: 2016-07-25 18:02:26.369776Z] Finished download-and-extract step (success) 11:02:26 INFO - [mozharness: 2016-07-25 18:02:26.370103Z] Running populate-webroot step. 11:02:26 INFO - Running pre-action listener: _resource_record_pre_action 11:02:26 INFO - Running main action method: populate_webroot 11:02:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:02:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:02:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:02:26 INFO - '--tppagecycles', 11:02:26 INFO - '7'], 11:02:26 INFO - 'tests': ['tsvgm']}}, 11:02:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:02:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:02:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:02:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:02:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:02:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:02:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:26 INFO - 'talos_options': ['--disable-e10s'], 11:02:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:02:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:02:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:26 INFO - 'talos_options': ['--disable-e10s'], 11:02:26 INFO - 'tests': ['damp', 'tps']}, 11:02:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:26 INFO - 'tests': ['damp', 'tps']}, 11:02:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:02:26 INFO - 'tests': ['dromaeo_dom']}, 11:02:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:02:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:02:26 INFO - 'tests': ['basic_compositor_video']}, 11:02:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:02:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:02:26 INFO - 'tests': ['a11yr', 11:02:26 INFO - 'ts_paint', 11:02:26 INFO - 'tpaint', 11:02:26 INFO - 'sessionrestore', 11:02:26 INFO - 'sessionrestore_no_auto_restore', 11:02:26 INFO - 'tabpaint']}, 11:02:26 INFO - 'other-e10s': {'tests': ['a11yr', 11:02:26 INFO - 'ts_paint', 11:02:26 INFO - 'tpaint', 11:02:26 INFO - 'sessionrestore', 11:02:26 INFO - 'sessionrestore_no_auto_restore', 11:02:26 INFO - 'tabpaint']}, 11:02:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:02:26 INFO - 'ts_paint', 11:02:26 INFO - 'tpaint', 11:02:26 INFO - 'sessionrestore', 11:02:26 INFO - 'sessionrestore_no_auto_restore', 11:02:26 INFO - 'tabpaint']}, 11:02:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:02:26 INFO - 'ts_paint', 11:02:26 INFO - 'tpaint', 11:02:26 INFO - 'sessionrestore', 11:02:26 INFO - 'sessionrestore_no_auto_restore', 11:02:26 INFO - 'tabpaint']}, 11:02:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:02:26 INFO - 'tests': ['a11yr', 11:02:26 INFO - 'ts_paint', 11:02:26 INFO - 'tpaint', 11:02:26 INFO - 'sessionrestore', 11:02:26 INFO - 'sessionrestore_no_auto_restore', 11:02:26 INFO - 'tabpaint']}, 11:02:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:02:26 INFO - 'tests': ['a11yr', 11:02:26 INFO - 'ts_paint', 11:02:26 INFO - 'tpaint', 11:02:26 INFO - 'sessionrestore', 11:02:26 INFO - 'sessionrestore_no_auto_restore', 11:02:26 INFO - 'tabpaint']}, 11:02:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:02:26 INFO - 'tests': ['tsvgx', 11:02:26 INFO - 'tsvgr_opacity', 11:02:26 INFO - 'tart', 11:02:26 INFO - 'tscrollx', 11:02:26 INFO - 'cart']}, 11:02:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:02:26 INFO - 'tsvgr_opacity', 11:02:26 INFO - 'tart', 11:02:26 INFO - 'tscrollx', 11:02:26 INFO - 'cart']}, 11:02:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:26 INFO - 'talos_options': ['--disable-e10s'], 11:02:26 INFO - 'tests': ['tp5o']}, 11:02:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:26 INFO - 'tests': ['tp5o']}, 11:02:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:26 INFO - 'talos_options': ['--disable-e10s', 11:02:26 INFO - '--xperf_path', 11:02:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:02:26 INFO - 'tests': ['tp5n']}, 11:02:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:26 INFO - 'talos_options': ['--xperf_path', 11:02:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:02:26 INFO - 'tests': ['tp5n']}}, 11:02:26 INFO - 'talos.zip': {'path': '', 11:02:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:02:26 INFO - Running post-action listener: _resource_record_post_action 11:02:26 INFO - [mozharness: 2016-07-25 18:02:26.386609Z] Finished populate-webroot step (success) 11:02:26 INFO - [mozharness: 2016-07-25 18:02:26.386698Z] Running create-virtualenv step. 11:02:26 INFO - Running pre-action listener: _resource_record_pre_action 11:02:26 INFO - Running main action method: create_virtualenv 11:02:26 INFO - Creating virtualenv /builds/slave/test/build/venv 11:02:26 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 11:02:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:02:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:02:26 INFO - Using real prefix '/usr' 11:02:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:02:27 INFO - Installing distribute.............................................................................................................................................................................................done. 11:02:28 INFO - Installing pip.................done. 11:02:29 INFO - Return code: 0 11:02:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:02:29 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')]} 11:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:29 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')]} 11:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:29 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 0xccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a3b0>, '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 0xf8b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', '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 11:02:29 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 11:02:29 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 11:02:29 INFO - Using env: {'DISPLAY': ':0', 11:02:29 INFO - 'HOME': '/home/cltbld', 11:02:29 INFO - 'LANG': 'en_US.UTF-8', 11:02:29 INFO - 'LANGUAGE': 'en_US:en', 11:02:29 INFO - 'LOGNAME': 'cltbld', 11:02:29 INFO - 'MAIL': '/var/mail/cltbld', 11:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:29 INFO - 'MOZ_NO_REMOTE': '1', 11:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:29 INFO - 'NO_EM_RESTART': '1', 11:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:29 INFO - 'PWD': '/builds/slave/test', 11:02:29 INFO - 'SHELL': '/bin/bash', 11:02:29 INFO - 'SHLVL': '1', 11:02:29 INFO - 'TERM': 'linux', 11:02:29 INFO - 'TMOUT': '86400', 11:02:29 INFO - 'USER': 'cltbld', 11:02:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', 11:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:29 INFO - '_': '/tools/buildbot/bin/python'} 11:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:29 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 11:02:29 INFO - Cleaning up... 11:02:29 INFO - Return code: 0 11:02:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:02:29 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')]} 11:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:29 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')]} 11:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:29 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 0xccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a3b0>, '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 0xf8b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', '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 11:02:29 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 11:02:29 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 11:02:29 INFO - Using env: {'DISPLAY': ':0', 11:02:29 INFO - 'HOME': '/home/cltbld', 11:02:29 INFO - 'LANG': 'en_US.UTF-8', 11:02:29 INFO - 'LANGUAGE': 'en_US:en', 11:02:29 INFO - 'LOGNAME': 'cltbld', 11:02:29 INFO - 'MAIL': '/var/mail/cltbld', 11:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:29 INFO - 'MOZ_NO_REMOTE': '1', 11:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:29 INFO - 'NO_EM_RESTART': '1', 11:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:29 INFO - 'PWD': '/builds/slave/test', 11:02:29 INFO - 'SHELL': '/bin/bash', 11:02:29 INFO - 'SHLVL': '1', 11:02:29 INFO - 'TERM': 'linux', 11:02:29 INFO - 'TMOUT': '86400', 11:02:29 INFO - 'USER': 'cltbld', 11:02:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', 11:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:29 INFO - '_': '/tools/buildbot/bin/python'} 11:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:29 INFO - Downloading/unpacking psutil>=3.1.1 11:02:29 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 11:02:29 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 11:02:29 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 11:02:29 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 11:02:29 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 11:02:29 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 11:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:02:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:02:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:02:31 INFO - Installing collected packages: psutil 11:02:31 INFO - Running setup.py install for psutil 11:02:31 INFO - building 'psutil._psutil_linux' extension 11:02:31 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 11:02:31 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 11:02:31 INFO - building 'psutil._psutil_posix' extension 11:02:31 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 11:02:31 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 11:02:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:02:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:02:31 INFO - Successfully installed psutil 11:02:31 INFO - Cleaning up... 11:02:32 INFO - Return code: 0 11:02:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:02:32 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')]} 11:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:32 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')]} 11:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:32 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 0xccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a3b0>, '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 0xf8b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', '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 11:02:32 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 11:02:32 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 11:02:32 INFO - Using env: {'DISPLAY': ':0', 11:02:32 INFO - 'HOME': '/home/cltbld', 11:02:32 INFO - 'LANG': 'en_US.UTF-8', 11:02:32 INFO - 'LANGUAGE': 'en_US:en', 11:02:32 INFO - 'LOGNAME': 'cltbld', 11:02:32 INFO - 'MAIL': '/var/mail/cltbld', 11:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:32 INFO - 'MOZ_NO_REMOTE': '1', 11:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:32 INFO - 'NO_EM_RESTART': '1', 11:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:32 INFO - 'PWD': '/builds/slave/test', 11:02:32 INFO - 'SHELL': '/bin/bash', 11:02:32 INFO - 'SHLVL': '1', 11:02:32 INFO - 'TERM': 'linux', 11:02:32 INFO - 'TMOUT': '86400', 11:02:32 INFO - 'USER': 'cltbld', 11:02:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', 11:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:32 INFO - '_': '/tools/buildbot/bin/python'} 11:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:02:32 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 11:02:32 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 11:02:32 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 11:02:32 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 11:02:32 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 11:02:32 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 11:02:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:02:34 INFO - Installing collected packages: mozsystemmonitor 11:02:34 INFO - Running setup.py install for mozsystemmonitor 11:02:34 INFO - Successfully installed mozsystemmonitor 11:02:34 INFO - Cleaning up... 11:02:34 INFO - Return code: 0 11:02:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:02:34 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')]} 11:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:34 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')]} 11:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:34 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a3b0>, '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 0xf8b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', '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 11:02:34 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==2.5.1'] in /builds/slave/test/build 11:02:34 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==2.5.1 11:02:34 INFO - Using env: {'DISPLAY': ':0', 11:02:34 INFO - 'HOME': '/home/cltbld', 11:02:34 INFO - 'LANG': 'en_US.UTF-8', 11:02:34 INFO - 'LANGUAGE': 'en_US:en', 11:02:34 INFO - 'LOGNAME': 'cltbld', 11:02:34 INFO - 'MAIL': '/var/mail/cltbld', 11:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:34 INFO - 'MOZ_NO_REMOTE': '1', 11:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:34 INFO - 'NO_EM_RESTART': '1', 11:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:34 INFO - 'PWD': '/builds/slave/test', 11:02:34 INFO - 'SHELL': '/bin/bash', 11:02:34 INFO - 'SHLVL': '1', 11:02:34 INFO - 'TERM': 'linux', 11:02:34 INFO - 'TMOUT': '86400', 11:02:34 INFO - 'USER': 'cltbld', 11:02:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', 11:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:34 INFO - '_': '/tools/buildbot/bin/python'} 11:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:34 INFO - Downloading/unpacking jsonschema==2.5.1 11:02:34 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 11:02:34 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 11:02:34 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 11:02:34 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 11:02:34 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 11:02:34 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 11:02:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:02:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:02:36 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 11:02:36 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 11:02:36 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 11:02:36 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 11:02:36 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 11:02:36 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 11:02:36 INFO - Downloading functools32-3.2.3-2.tar.gz 11:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:02:36 INFO - warning: no files found matching '*.txt' 11:02:36 INFO - no previously-included directories found matching 'build' 11:02:36 INFO - no previously-included directories found matching 'dist' 11:02:36 INFO - no previously-included directories found matching '.git*' 11:02:36 INFO - Installing collected packages: jsonschema, functools32 11:02:36 INFO - Running setup.py install for functools32 11:02:37 INFO - warning: no files found matching '*.txt' 11:02:37 INFO - no previously-included directories found matching 'build' 11:02:37 INFO - no previously-included directories found matching 'dist' 11:02:37 INFO - no previously-included directories found matching '.git*' 11:02:37 INFO - Successfully installed jsonschema functools32 11:02:37 INFO - Cleaning up... 11:02:37 INFO - Return code: 0 11:02:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:02:37 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')]} 11:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:37 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')]} 11:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:37 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a3b0>, '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 0xf8b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', '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 11:02:37 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:02:37 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 functools32==3.2.3-2 11:02:37 INFO - Using env: {'DISPLAY': ':0', 11:02:37 INFO - 'HOME': '/home/cltbld', 11:02:37 INFO - 'LANG': 'en_US.UTF-8', 11:02:37 INFO - 'LANGUAGE': 'en_US:en', 11:02:37 INFO - 'LOGNAME': 'cltbld', 11:02:37 INFO - 'MAIL': '/var/mail/cltbld', 11:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:37 INFO - 'MOZ_NO_REMOTE': '1', 11:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:37 INFO - 'NO_EM_RESTART': '1', 11:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:37 INFO - 'PWD': '/builds/slave/test', 11:02:37 INFO - 'SHELL': '/bin/bash', 11:02:37 INFO - 'SHLVL': '1', 11:02:37 INFO - 'TERM': 'linux', 11:02:37 INFO - 'TMOUT': '86400', 11:02:37 INFO - 'USER': 'cltbld', 11:02:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', 11:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:37 INFO - '_': '/tools/buildbot/bin/python'} 11:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:02:37 INFO - Cleaning up... 11:02:37 INFO - Return code: 0 11:02:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:02:37 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')]} 11:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:37 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')]} 11:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:37 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 0xccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a3b0>, '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 0xf8b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', '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 11:02:37 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 11:02:37 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 11:02:37 INFO - Using env: {'DISPLAY': ':0', 11:02:37 INFO - 'HOME': '/home/cltbld', 11:02:37 INFO - 'LANG': 'en_US.UTF-8', 11:02:37 INFO - 'LANGUAGE': 'en_US:en', 11:02:37 INFO - 'LOGNAME': 'cltbld', 11:02:37 INFO - 'MAIL': '/var/mail/cltbld', 11:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:37 INFO - 'MOZ_NO_REMOTE': '1', 11:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:37 INFO - 'NO_EM_RESTART': '1', 11:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:37 INFO - 'PWD': '/builds/slave/test', 11:02:37 INFO - 'SHELL': '/bin/bash', 11:02:37 INFO - 'SHLVL': '1', 11:02:37 INFO - 'TERM': 'linux', 11:02:37 INFO - 'TMOUT': '86400', 11:02:37 INFO - 'USER': 'cltbld', 11:02:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', 11:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:37 INFO - '_': '/tools/buildbot/bin/python'} 11:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:37 INFO - Downloading/unpacking blobuploader==1.2.4 11:02:37 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 11:02:37 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 11:02:37 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 11:02:37 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 11:02:37 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 11:02:37 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 11:02:39 INFO - Downloading blobuploader-1.2.4.tar.gz 11:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:02:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:02:39 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 11:02:39 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 11:02:39 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 11:02:39 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 11:02:39 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 11:02:39 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 11:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:02:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:02:39 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 11:02:39 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 11:02:39 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 11:02:39 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 11:02:39 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 11:02:39 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 11:02:40 INFO - Downloading docopt-0.6.1.tar.gz 11:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:02:40 INFO - Installing collected packages: blobuploader, requests, docopt 11:02:40 INFO - Running setup.py install for blobuploader 11:02:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:02:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:02:40 INFO - Running setup.py install for requests 11:02:40 INFO - Running setup.py install for docopt 11:02:40 INFO - Successfully installed blobuploader requests docopt 11:02:40 INFO - Cleaning up... 11:02:40 INFO - Return code: 0 11:02:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02:40 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')]} 11:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:40 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')]} 11:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:40 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 0xccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a3b0>, '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 0xf8b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', '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 11:02:40 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 11:02:40 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 11:02:40 INFO - Using env: {'DISPLAY': ':0', 11:02:40 INFO - 'HOME': '/home/cltbld', 11:02:40 INFO - 'LANG': 'en_US.UTF-8', 11:02:40 INFO - 'LANGUAGE': 'en_US:en', 11:02:40 INFO - 'LOGNAME': 'cltbld', 11:02:40 INFO - 'MAIL': '/var/mail/cltbld', 11:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:40 INFO - 'MOZ_NO_REMOTE': '1', 11:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:40 INFO - 'NO_EM_RESTART': '1', 11:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:40 INFO - 'PWD': '/builds/slave/test', 11:02:40 INFO - 'SHELL': '/bin/bash', 11:02:40 INFO - 'SHLVL': '1', 11:02:40 INFO - 'TERM': 'linux', 11:02:40 INFO - 'TMOUT': '86400', 11:02:40 INFO - 'USER': 'cltbld', 11:02:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', 11:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:40 INFO - '_': '/tools/buildbot/bin/python'} 11:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:02:41 INFO - Running setup.py (path:/tmp/pip-GDTPVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:02:41 INFO - Running setup.py (path:/tmp/pip-2ViqPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:02:41 INFO - Running setup.py (path:/tmp/pip-orMrMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:02:41 INFO - Running setup.py (path:/tmp/pip-2XlWbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:02:41 INFO - Running setup.py (path:/tmp/pip-z93HXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:02:41 INFO - Running setup.py (path:/tmp/pip-zar4hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:02:41 INFO - Running setup.py (path:/tmp/pip-Fh6GWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:02:41 INFO - Running setup.py (path:/tmp/pip-NzdMmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:02:41 INFO - Running setup.py (path:/tmp/pip-nW77cM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:02:41 INFO - Running setup.py (path:/tmp/pip-qC4oyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:02:41 INFO - Running setup.py (path:/tmp/pip-GWCCWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:02:41 INFO - Running setup.py (path:/tmp/pip-5I3eXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:02:41 INFO - Running setup.py (path:/tmp/pip-aY9QlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:02:42 INFO - Running setup.py (path:/tmp/pip-G2ChRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:42 INFO - Running setup.py (path:/tmp/pip-x5xRUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:02:42 INFO - Running setup.py (path:/tmp/pip-fppvV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:02:42 INFO - Running setup.py (path:/tmp/pip-5ah0WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:02:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:02:42 INFO - Running setup.py install for manifestparser 11:02:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:02:42 INFO - Running setup.py install for mozcrash 11:02:42 INFO - Running setup.py install for mozdebug 11:02:42 INFO - Running setup.py install for mozdevice 11:02:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:02:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:02:42 INFO - Running setup.py install for mozfile 11:02:42 INFO - Running setup.py install for mozhttpd 11:02:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:02:42 INFO - Running setup.py install for mozinfo 11:02:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:02:43 INFO - Running setup.py install for mozInstall 11:02:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:02:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:02:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:02:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:02:43 INFO - Running setup.py install for mozleak 11:02:43 INFO - Running setup.py install for mozlog 11:02:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:02:43 INFO - Running setup.py install for moznetwork 11:02:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:02:43 INFO - Running setup.py install for mozprocess 11:02:43 INFO - Running setup.py install for mozprofile 11:02:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:02:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:02:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:02:43 INFO - Running setup.py install for mozrunner 11:02:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:02:43 INFO - Running setup.py install for mozscreenshot 11:02:43 INFO - Running setup.py install for moztest 11:02:43 INFO - Running setup.py install for mozversion 11:02:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:02:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:02:44 INFO - Cleaning up... 11:02:44 INFO - Return code: 0 11:02:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02:44 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')]} 11:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:44 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')]} 11:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:44 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 0xccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a3b0>, '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 0xf8b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', '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 11:02:44 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 11:02:44 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 11:02:44 INFO - Using env: {'DISPLAY': ':0', 11:02:44 INFO - 'HOME': '/home/cltbld', 11:02:44 INFO - 'LANG': 'en_US.UTF-8', 11:02:44 INFO - 'LANGUAGE': 'en_US:en', 11:02:44 INFO - 'LOGNAME': 'cltbld', 11:02:44 INFO - 'MAIL': '/var/mail/cltbld', 11:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:44 INFO - 'MOZ_NO_REMOTE': '1', 11:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:44 INFO - 'NO_EM_RESTART': '1', 11:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:44 INFO - 'PWD': '/builds/slave/test', 11:02:44 INFO - 'SHELL': '/bin/bash', 11:02:44 INFO - 'SHLVL': '1', 11:02:44 INFO - 'TERM': 'linux', 11:02:44 INFO - 'TMOUT': '86400', 11:02:44 INFO - 'USER': 'cltbld', 11:02:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', 11:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:44 INFO - '_': '/tools/buildbot/bin/python'} 11:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:02:44 INFO - Running setup.py (path:/tmp/pip-OtIzx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:02:44 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)) 11:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:02:44 INFO - Running setup.py (path:/tmp/pip-aCWMLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:02:44 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)) 11:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:02:44 INFO - Running setup.py (path:/tmp/pip-megFsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:02:44 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)) 11:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:02:44 INFO - Running setup.py (path:/tmp/pip-bI5TmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:02:44 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)) 11:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:02:44 INFO - Running setup.py (path:/tmp/pip-55dEt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:02:44 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)) 11:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:02:44 INFO - Running setup.py (path:/tmp/pip-WqEunT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:02:44 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)) 11:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:02:44 INFO - Running setup.py (path:/tmp/pip-3HO4WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:02:44 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)) 11:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:02:44 INFO - Running setup.py (path:/tmp/pip-4u_FPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:02:44 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)) 11:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:02:44 INFO - Running setup.py (path:/tmp/pip-2xCC7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:02:44 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)) 11:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:02:44 INFO - Running setup.py (path:/tmp/pip-4aEOT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 11:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:02:45 INFO - Running setup.py (path:/tmp/pip-hofLms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:02:45 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)) 11:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:02:45 INFO - Running setup.py (path:/tmp/pip-aeNAhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 11:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:02:45 INFO - Running setup.py (path:/tmp/pip-UqNG1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:02:45 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)) 11:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:02:45 INFO - Running setup.py (path:/tmp/pip-Hm88EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 11:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:45 INFO - Running setup.py (path:/tmp/pip-2ZBrHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:02:45 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)) 11:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:02:45 INFO - Running setup.py (path:/tmp/pip-uOwn1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:02:45 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)) 11:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:02:45 INFO - Running setup.py (path:/tmp/pip-l8JDeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:02:45 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)) 11:02:45 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)) 11:02:45 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)) 11:02:45 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)) 11:02:45 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)) 11:02:45 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)) 11:02:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:02:45 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 11:02:45 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 11:02:45 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 11:02:45 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 11:02:45 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 11:02:45 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 11:02:47 INFO - Downloading blessings-1.6.tar.gz 11:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:02:47 INFO - Installing collected packages: blessings 11:02:47 INFO - Running setup.py install for blessings 11:02:47 INFO - Successfully installed blessings 11:02:47 INFO - Cleaning up... 11:02:47 INFO - Return code: 0 11:02:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:02:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:02:47 INFO - Reading from file tmpfile_stdout 11:02:47 INFO - Current package versions: 11:02:47 INFO - argparse == 1.2.1 11:02:47 INFO - blessings == 1.6 11:02:47 INFO - blobuploader == 1.2.4 11:02:47 INFO - docopt == 0.6.1 11:02:47 INFO - functools32 == 3.2.3-2 11:02:47 INFO - jsonschema == 2.5.1 11:02:47 INFO - manifestparser == 1.1 11:02:47 INFO - mozInstall == 1.12 11:02:47 INFO - mozcrash == 0.17 11:02:47 INFO - mozdebug == 0.1 11:02:47 INFO - mozdevice == 0.48 11:02:47 INFO - mozfile == 1.2 11:02:47 INFO - mozhttpd == 0.7 11:02:47 INFO - mozinfo == 0.9 11:02:47 INFO - mozleak == 0.1 11:02:47 INFO - mozlog == 3.3 11:02:47 INFO - moznetwork == 0.27 11:02:47 INFO - mozprocess == 0.23 11:02:47 INFO - mozprofile == 0.28 11:02:47 INFO - mozrunner == 6.12 11:02:47 INFO - mozscreenshot == 0.1 11:02:47 INFO - mozsystemmonitor == 0.3 11:02:47 INFO - moztest == 0.7 11:02:47 INFO - mozversion == 1.4 11:02:47 INFO - psutil == 3.1.1 11:02:47 INFO - requests == 1.2.3 11:02:47 INFO - wsgiref == 0.1.2 11:02:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:02:47 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')]} 11:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:47 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')]} 11:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:47 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 0xccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a3b0>, '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 0xf8b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', '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 11:02:47 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 11:02:47 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 11:02:47 INFO - Using env: {'DISPLAY': ':0', 11:02:47 INFO - 'HOME': '/home/cltbld', 11:02:47 INFO - 'LANG': 'en_US.UTF-8', 11:02:47 INFO - 'LANGUAGE': 'en_US:en', 11:02:47 INFO - 'LOGNAME': 'cltbld', 11:02:47 INFO - 'MAIL': '/var/mail/cltbld', 11:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:47 INFO - 'MOZ_NO_REMOTE': '1', 11:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:47 INFO - 'NO_EM_RESTART': '1', 11:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:47 INFO - 'PWD': '/builds/slave/test', 11:02:47 INFO - 'SHELL': '/bin/bash', 11:02:47 INFO - 'SHLVL': '1', 11:02:47 INFO - 'TERM': 'linux', 11:02:47 INFO - 'TMOUT': '86400', 11:02:47 INFO - 'USER': 'cltbld', 11:02:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', 11:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:47 INFO - '_': '/tools/buildbot/bin/python'} 11:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:48 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)) 11:02:48 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)) 11:02:48 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)) 11:02:48 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)) 11:02:48 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)) 11:02:48 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)) 11:02:48 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)) 11:02:48 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)) 11:02:48 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)) 11:02:48 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)) 11:02:48 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)) 11:02:48 INFO - Cleaning up... 11:02:48 INFO - Return code: 0 11:02:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:02:48 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')]} 11:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:48 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')]} 11:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:48 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 0xccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8a3b0>, '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 0xf8b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8b740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', '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 11:02:48 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 11:02:48 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 11:02:48 INFO - Using env: {'DISPLAY': ':0', 11:02:48 INFO - 'HOME': '/home/cltbld', 11:02:48 INFO - 'LANG': 'en_US.UTF-8', 11:02:48 INFO - 'LANGUAGE': 'en_US:en', 11:02:48 INFO - 'LOGNAME': 'cltbld', 11:02:48 INFO - 'MAIL': '/var/mail/cltbld', 11:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:48 INFO - 'MOZ_NO_REMOTE': '1', 11:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:48 INFO - 'NO_EM_RESTART': '1', 11:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:48 INFO - 'PWD': '/builds/slave/test', 11:02:48 INFO - 'SHELL': '/bin/bash', 11:02:48 INFO - 'SHLVL': '1', 11:02:48 INFO - 'TERM': 'linux', 11:02:48 INFO - 'TMOUT': '86400', 11:02:48 INFO - 'USER': 'cltbld', 11:02:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', 11:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:48 INFO - '_': '/tools/buildbot/bin/python'} 11:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:02:48 INFO - Cleaning up... 11:02:48 INFO - Return code: 0 11:02:48 INFO - Running post-action listener: _resource_record_post_action 11:02:48 INFO - Running post-action listener: _start_resource_monitoring 11:02:48 INFO - Starting resource monitoring. 11:02:48 INFO - [mozharness: 2016-07-25 18:02:48.374441Z] Finished create-virtualenv step (success) 11:02:48 INFO - [mozharness: 2016-07-25 18:02:48.374888Z] Running install step. 11:02:48 INFO - Running pre-action listener: _resource_record_pre_action 11:02:48 INFO - Running main action method: install 11:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:02:48 INFO - Reading from file tmpfile_stdout 11:02:48 INFO - Detecting whether we're running mozinstall >=1.0... 11:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:02:48 INFO - Reading from file tmpfile_stdout 11:02:48 INFO - Output received: 11:02:48 INFO - Usage: mozinstall [options] installer 11:02:48 INFO - Options: 11:02:48 INFO - -h, --help show this help message and exit 11:02:48 INFO - -d DEST, --destination=DEST 11:02:48 INFO - Directory to install application into. [default: 11:02:48 INFO - "/builds/slave/test"] 11:02:48 INFO - --app=APP Application being installed. [default: firefox] 11:02:48 INFO - mkdir: /builds/slave/test/build/application 11:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:03:05 INFO - Reading from file tmpfile_stdout 11:03:05 INFO - Output received: 11:03:05 INFO - /builds/slave/test/build/application/firefox/firefox 11:03:05 INFO - Running post-action listener: _resource_record_post_action 11:03:05 INFO - [mozharness: 2016-07-25 18:03:05.959367Z] Finished install step (success) 11:03:05 INFO - [mozharness: 2016-07-25 18:03:05.959616Z] Running run-tests step. 11:03:05 INFO - Running pre-action listener: _resource_record_pre_action 11:03:05 INFO - Running main action method: run_tests 11:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:03:05 INFO - Python 2.7.3 11:03:05 INFO - Return code: 0 11:03:05 INFO - grabbing minidump binary from tooltool 11:03:05 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')]} 11:03:05 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 0xf8a3b0>, '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 0xf8b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf8b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:03:05 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 11:03:05 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 11:03:05 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 11:03:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:03:06 INFO - Return code: 0 11:03:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:03:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:03:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:03:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:03:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:03:06 INFO - Using env: {'DISPLAY': ':0', 11:03:06 INFO - 'HOME': '/home/cltbld', 11:03:06 INFO - 'LANG': 'en_US.UTF-8', 11:03:06 INFO - 'LANGUAGE': 'en_US:en', 11:03:06 INFO - 'LOGNAME': 'cltbld', 11:03:06 INFO - 'MAIL': '/var/mail/cltbld', 11:03:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:03:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:06 INFO - 'MOZ_NO_REMOTE': '1', 11:03:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:06 INFO - 'NO_EM_RESTART': '1', 11:03:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:06 INFO - 'PWD': '/builds/slave/test', 11:03:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:03:06 INFO - 'SHELL': '/bin/bash', 11:03:06 INFO - 'SHLVL': '1', 11:03:06 INFO - 'TERM': 'linux', 11:03:06 INFO - 'TMOUT': '86400', 11:03:06 INFO - 'USER': 'cltbld', 11:03:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117', 11:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:06 INFO - '_': '/tools/buildbot/bin/python'} 11:03:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:03:06 INFO - mozversion application_buildid: 20160725083025 11:03:06 INFO - mozversion application_changeset: 63c2b8192228dee0139431eded5b92a9db126de2 11:03:06 INFO - mozversion application_display_name: Nightly 11:03:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:03:06 INFO - mozversion application_name: Firefox 11:03:06 INFO - mozversion application_remotingname: firefox 11:03:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:03:06 INFO - mozversion application_vendor: Mozilla 11:03:06 INFO - mozversion application_version: 50.0a1 11:03:06 INFO - mozversion platform_buildid: 20160725083025 11:03:06 INFO - mozversion platform_changeset: 63c2b8192228dee0139431eded5b92a9db126de2 11:03:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:03:06 INFO - mozversion platform_version: 50.0a1 11:03:06 INFO - using testdate: 1469469786 11:03:06 INFO - actual date: 1469469786 11:03:06 INFO - starting webserver on 'localhost:52049' 11:03:06 INFO - SUITE-START | Running 2 tests 11:03:06 INFO - TEST-START | dromaeo_css 11:03:06 INFO - operating with platform_type : linux_ 11:03:06 INFO - Initialising browser for dromaeo_css test... 11:03:06 INFO - TEST-INFO | started process 27901 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBSays8/profile http://localhost:52049/getInfo.html) 11:03:09 INFO - PROCESS | 27901 | JavaScript error: , line 0: uncaught exception: undefined 11:03:10 INFO - PROCESS | 27901 | __metrics Screen width/height:1600/1200 11:03:10 INFO - PROCESS | 27901 | colorDepth:24 11:03:10 INFO - PROCESS | 27901 | Browser inner width/height: 1024/697 11:03:10 INFO - PROCESS | 27901 | __metrics 11:03:10 INFO - PROCESS | 27901 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:03:10 INFO - PROCESS | 27901 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:03:11 INFO - TEST-INFO | 27901: exit 0 11:03:11 INFO - Browser initialized. 11:03:11 INFO - Running cycle 1/1 for dromaeo_css test... 11:03:11 INFO - TEST-INFO | started process 27980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBSays8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:03:23 INFO - PROCESS | 27980 | RSS: Main: 157413376 11:03:23 INFO - PROCESS | 27980 | 11:04:14 INFO - PROCESS | 27980 | 1469469854941 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] 11:06:23 INFO - PROCESS | 27980 | Cycle 1(1): loaded http://localhost:52049/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52049/tests/dromaeo/cssquery-ext.html) 11:06:24 INFO - PROCESS | 27980 | RSS: Main: 249049088 11:06:24 INFO - PROCESS | 27980 | 11:09:26 INFO - PROCESS | 27980 | Cycle 1(1): loaded http://localhost:52049/tests/dromaeo/cssquery-ext.html (next: http://localhost:52049/tests/dromaeo/cssquery-jquery.html) 11:09:27 INFO - PROCESS | 27980 | RSS: Main: 250392576 11:09:27 INFO - PROCESS | 27980 | 11:12:29 INFO - PROCESS | 27980 | Cycle 1(1): loaded http://localhost:52049/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52049/tests/dromaeo/cssquery-mootools.html) 11:12:29 INFO - PROCESS | 27980 | RSS: Main: 194277376 11:12:29 INFO - PROCESS | 27980 | 11:15:31 INFO - PROCESS | 27980 | Cycle 1(1): loaded http://localhost:52049/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52049/tests/dromaeo/cssquery-prototype.html) 11:15:32 INFO - PROCESS | 27980 | RSS: Main: 219938816 11:15:32 INFO - PROCESS | 27980 | 11:18:35 INFO - PROCESS | 27980 | Cycle 1(1): loaded http://localhost:52049/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52049/tests/dromaeo/cssquery-yui.html) 11:18:35 INFO - PROCESS | 27980 | RSS: Main: 190480384 11:18:35 INFO - PROCESS | 27980 | 11:21:38 INFO - PROCESS | 27980 | Cycle 1(1): loaded http://localhost:52049/tests/dromaeo/cssquery-yui.html (next: http://localhost:52049/tests/dromaeo/cssquery-dojo.html) 11:21:39 INFO - PROCESS | 27980 | RSS: Main: 281763840 11:21:39 INFO - PROCESS | 27980 | 11:21:39 INFO - PROCESS | 27980 | __start_tp_report 11:21:39 INFO - PROCESS | 27980 | _x_x_mozilla_page_load 11:21:39 INFO - PROCESS | 27980 | _x_x_mozilla_page_load_details 11:21:39 INFO - PROCESS | 27980 | |i|pagename|runs| 11:21:39 INFO - PROCESS | 27980 | |0;dojo.html;3071.5853359796433;3072.9231769205767;3097.086359523943;3109.486934655782;3150;5246.108161612526;5330.813421530247;5336.733163341837;5431.293931788867;5446.319210098738;5355.4912283333115;5364.812231571896;5383.273258110154;5409.918851217235;5474.151506516487;4920.8031678732805;4944.332515110468;4959.132151873426;4973.552380285773;5108.795648174068;5011;5029.069622119901;5030.647854650176;5034;5035.672681275705;4811.542903424169;4856.490068542787;4866.878328041792;4880.536349046835;4928.999999999982;4824.107540105057;4930.03864246472;4938.2839488274;4941.654084214107;4943.2585112233455;4846.563809257149;4846.660733748639;4853.102176097434;4895.534924182197;4927.384076990376;5403.756830942617;5405.18922161675;5449.427810079924;5456.863578410572;5465.863353416156;5640.238567793336;5804.303483581997;5816.97091514544;5822.505087067604;5871.500922421599;5662.433756624346;5704.429557044304;5706.4864162225595;5752.108423194411;5788.913166302466;5374.811881584164;5401.351837779453;5402.405735369146;5406.783728650849;5415.891682166334;5776.537876969833;5779;5954.55340849438;5961.135635332853;5961.880762384815;5583.776648934078;5590.972045139748;5604.355499117653;5640.746166422438;5645.350784659817;5682.715864206773;5684.175794509773;5730.426957304237;5738.713064346766;5751.194832723422;5557.055300598908;5660.349059858169;5679.375268720438;5685.346185188673;5686.800961966312;5733.856653583611;5764.855878603068;5776.104703770922;5818.650880947157;5830.416958304136;4368.475782906008;4404.911901761947;4411.977940110343;4412.933805992912;4447.155040542287;3883.708721845873;3895.6104389561383;3953.683705303569;3959.544652364957;3978.980105099514;5471.261379713767;5511.118221084687;5512.228288039678;5517.531009864127;5564.972175139098;5834.474897259267;5841.357450680422;5850.970745146247;5853.9414605854245;5890.911636325459;5348.545373643206;5433.673979561239;5520.199571062173;5524.4199359067525;5526.171074338881;5027.296178535008;5031.295618613397;5035.093683137071;5066.442691303953;5075.441701412841;5897.882042359129;5919.940800591939;5922.763089476459;5927.31835838884;5929.229200203946;5498.670079795225;5720.971395142998;5753.05074662676;5776.075827867521;5777.971110144591;5987.550933679904;5993.430624090704;6010.849728756816;6052.243469566304;6054.788082417094;5737.713114344183;5748.568857335633;5760.1935728998815;5760.8271751847515;5777.9133313001175;5613.129964855454;5722.74247658848;5860.208871802422;5879.265091863517;5881.441263080001;5609.747561359667;5663.915041274302;5669.773209071591;5676.091825307931;5714.457126572969;5613.270274864241;5639.915401269066;5649.887002260014;5664.886702265849;5666.15007748841;5292.311999440049;5508.228847961369;5614.101743720985;5617.213590097472;5623.8875222496135;5591.8881622368135;5745.540356771365;5752.453516915886;5752.9712351437975;5765.019946609003;5580.190872323409;5584.190292407659;5584.692841893735;5585.497305242548;5586.608937374344 11:21:39 INFO - PROCESS | 27980 | |1;ext.html;599.8290487211144;613.435639211925;618.8669436071245;621.8507558186037;639.2265358915712;44063.33904991423;45805.77097114518;45823.08353832926;45962.54037459625;49350.50649493504;47559;47898.760506197505;47953.76023119888;47962.0407591848;48006.75996620012;9048.411853229536;9196.678116265932;9198;9203.17171454569;9207.217386522154;8877.378583499158;8947.64209431622;8958.417702849294;8968.730938071836;8971.641134354619;8982.865257021118;9011;9018.729438116867;9024.458532488039;9031.548422578844;8979.742836002932;9013.909860901373;9015.594298256594;9017.323700722407;9017.639294428214;9030.909690903138;9032.77418064547;9085.954570227173;9092.954535227347;9098.954505227432;44284.77857610691;44606.776966115285;44766.77616611896;44778.776106119585;44837.775811121064;3456.4469684850555;3456.7580269381156;3474.2877710069374;3656.9085772855624;3770.2082562661876;33491.6650833491;33499.49750753741;33777;33791;35247.64752352469;4412.84555040572;4467.486239082515;4536.7504787236685;4537.387452693877;4587.610053145487;390664.2800715983;392106;392243.15513689566;392603.99999999715;392657;52785;59790;60287;60317.39682603118;63693;63985.360146398874;64264.678676606316;64695;64985.67507162529;65083.34916650868;16688.082155481323;16784.664306713796;16936.745948810778;16943.406980755863;16946.23741931616;12595.811062834066;12753.872461275454;12794.296313702836;12800.80798788019;12831.743365132645;15527;17115.22981465837;17651.205695743723;17655.117244137742;17899.821001790075;5925.703714814242;5981.79063732776;5988.191594134823;5988.640681559121;6054.727537260834;943.155875491445;1005.4319309590059;1054.8628678271775;1103.8289065194908;1177.7232350397649;32702;33015.50476742803;33155;33222.50166247508;33273.66726332754;1115.286216821235;1117.6591139702307;1152.8558930133734;1226.8957138643136;1248.1138391741783;16736.497905062624;17179.570510737332;17228.741568876478;17247.137643117792;17383.73924391135;563969;566055;567094;569018;571226;60226.69886650539;60660.393396066356;60687;60703;60718;1310.1745900083076;1373.196679942245;1393.2337214531967;1400.2158791076827;1401.978970315446;31422.685773141977;31898.20254493656;31931.36137277288;32803.58092096416;32932.50601240935;54269;54503.45496544984;54673;54698.45301547093;54737.72631136819;452238;452714;454912;455053;455060;32371.676283237808;43087.35368969531;43637.78181109074;43970.58161801132;44309.33535997027;48296.275555865985;48699;48729.26906096341;48911.755441222565;48974.51025489842;40670.38994415027;42205.155896882505;42310.5768942319;42452;44046.77976610096;41387.1722565553;41592;41702.79148604238;42619;43146.784266078466;40571.79922163551;41767.16465670609;41939.16121677488;42382.57617423786;42704.57295427006;33739.662603373654;36706.26587468289;36850.63149368579;36907.14463529998;38003.239935201695;28124.156275311772;28144.43711125807;28298;28379.86480540838;28445.146645600664 11:21:39 INFO - PROCESS | 27980 | |2;jquery.html;367.28562945071843;381.44309308409703;385.77432202161737;397.46937837986286;418.8827128404046;14356.353964071615;16443.75334369984;18967.430977070675;19535.70696439551;19541.609167816652;18489;18651.347202847905;18734.34429794954;18771.906140469313;19020.904895475538;4099.364598487239;5438.700871452059;5628.887422251552;5632;5632.831015069554;6025.3372129065765;6257.687115644199;6332.715027823736;6392.680365981682;6394.520410969196;6114.205153330061;6231.968840155793;6279.434850863421;6348.269948955883;6356;6234.594751341171;6265.96867015662;6269.749210031593;6273.341299163613;6276.654783986879;5409.756560954766;5578.30271216098;5626.690532020737;5628.099504079369;5634.521065709419;22672.659910101363;23111.88444057786;23123;23140.305790826304;23375.883120584287;2437.573424650679;2458.5943319352286;2460.200434858678;2544.3257536752776;3012.487877060905;13720.176789392668;14353.569392918229;14461.638459038502;15039.849601504064;15094.094354338775;1845.2250054976942;1873.812618738129;1909.8185672361103;1960.3236883275247;2010.6481365760933;80125.19874801235;81263;82354.58822705908;83273.16726832776;83314;10122.54448549817;10213.897861021444;10316;10357.4303413313;10559.788804223872;14494.85505144935;14494.927525362305;14496.130232185891;14510.1293922365;14510.274486275644;7372;7525.661345239478;7616.885746713804;7653.349465295512;7945.205479452125;7353.70585176587;7459.962700186465;7634.083909930844;7650.4644674872225;7653.311201991847;6261.405166509175;6476.514261430411;6479.838004049842;6489.091527186198;6635.402813746786;1831.2583403721515;1875.012407440482;1878.126671097946;1899.43017094871;1961.656710075731;956.048731512136;974.2011550528499;978.1734434402919;994.1202036198017;1024.7284469615558;19554.804451955297;19907.800921990885;19971.60056798856;20043.498912527302;20197.293094741613;1040.6721882607105;1048.842673598951;1052.5211028981794;1054.536004158168;1076.1068313299943;10562.683119506428;10948.124150067975;11036.889631103746;11368;11370.829437558443;549329;550653;550813;551015;556588;78412;79229.60385198037;79499;80106;83414;953.113604347963;979.7060881735451;989.7426669066094;990.4849478271259;998.0668075349716;17002.319907203575;17128.143592820557;17416.216270268123;17442.389516366868;17889.37387191442;40496.79751601223;40619.390709139974;41000.38499422571;41387.586124138375;42664;52347;53431;53450;53891.191632126334;54005.91988160136;8199.22107399796;8345.290650294794;8373.623186956724;8529.786755330919;8611.526366049928;12342.568010119603;12971.610851674464;12983.870161298266;13030.869691302965;13151.671208219872;11332.320060796379;11433.428328583372;11604.6518604442;11713.824292635447;12009.81985270239;11335.546578136782;11539.134564907497;11620.593279235187;11681.941590291994;12025.75948481008;11578.189526733384;11705.765884682429;12164.939175304067;12200.938995304967;12275.447604857623;8296.792580185544;8538;8574.442661227;8580.184882436159;8659.653613855375;11545.711357215801;11549.653510394366;11731.824022639837;11782.234154779911;12070.637880863587 11:21:39 INFO - PROCESS | 27980 | |3;mootools.html;1341.0411555737646;1427.7786943023832;1483.940642374305;1574.134226175603;1758.4021432712866;8305.418620696546;8645.049044605088;8688.956555217232;8854.513001784899;8856.645734170641;8754.212120909116;8773.692920747775;8781;8794.428362156455;8853.42452740573;2344.3553022918663;2369.1471070414636;2369.9644505332435;2370.277065495023;2374.3114496795906;2329.4758679297192;2340.4031971847157;2395.940101497459;2399.3521749127726;2400.327908185702;2350.894209760565;2352.4001379648166;2382.702162229721;2384.3204686664303;2385.8687772172525;2267.727872655292;2309.965350519752;2318.7913087822094;2326.8022218111482;2347.14329269817;2297.2279260780306;2327.592671282519;2327.767223277676;2333.871637059961;2335.135999680112;8865.157810008039;8868.11318868108;8924.375293729441;8942.150495702897;8981.146791054905;5093.541581257705;5153.768080436389;5193.63644544882;5199.66202196856;5209.270702101709;3277.147941535218;3336.966630333714;3337.7830441021497;3400.795952242873;3409.6760807723226;1195.3545085653736;1200.1898718365069;1203.8615559210716;1213.071999920062;1216.8783121687761;11939.223950443193;11965.222260553037;12017.098717596215;12023.57917472893;12037.518499260106;4127.731697439657;4291.892702682458;4394.209042372404;4436.556344365602;4436.711613745097;9550.806149231346;9575.856362154573;9577.377470464537;9581.856272155923;9581.904180958241;5065.594752419797;5068.4424713281505;5074.67014644047;5076.898462030813;5078.415982162025;4196.076863090116;4633.050224703928;4699.436067671902;4744.122337367598;4763.237881938873;3653.9634603654154;3767.547894252707;3824.464574959508;3839.9040023999623;3840.7695538267235;1086.8152414089623;1169.2399940039043;1169.900558452541;1170.9590164344377;1187.804012337972;917.7200953709049;926.6061923682408;928.6424726480219;958.9738979292091;980.9019098090276;5525.364583072998;5587.329520457572;5736.368999410145;5913.49735272498;6109.694515274218;907.9863802042975;909.1090731083575;914.4147745442922;924.3252425729255;964.3105179796479;3743.794091324949;3870.2066076454257;3875.6899448044087;3933.292007438631;3938.330483817758;10629.787404251872;11166.665000050012;11179.105671546256;11180.720481987853;11182.21724479295;10785.730356741144;11075.72310692239;11130.888691113147;11135.944320278346;11166.776664466664;8197.672093116209;8453.788655283666;8457.746267611981;8464.195901389236;8470.15298470148;5622.971885140548;5623.690697011703;5653.886922261614;5706.258186435903;5882;9878.555465003948;10024.649137280161;10070.194384449373;10271.229657775846;10282.485875706334;9990.750231244278;10052.597896084075;10197.54111064989;10321.122704570196;10408.27142100076;7206.2793720627515;7333.156686980852;7532.736354227576;8082.595870206584;8189.344852411912;8516.276116530164;8721.171488708816;8783;8789.296856251613;8826.779330516789;7697.6151192441275;7719.536827790126;7849.803754906173;7898.802529936797;7935.722249721232;7204.819879503054;7523.623818809147;7634.236576342321;7640.923590764021;7645.159032506531;6792.0830687856505;6873.965630171817;6874.65626718652;6877.071595334766;6879.862402751817;5115.667481613683;5144.9742751286;5178.844634660966;5215.113430716863;5334.226537152169;5245.318108645852;5331.973340133274;5353.732313384237;5386.811461598825;5572.693501857437 11:21:39 INFO - PROCESS | 27980 | |4;prototype.html;330.09389226573063;331.0630914511933;337.1604704286328;342.5632318793538;347.44235502019245;5105.310783044288;5246.580273578114;5295.523402893738;5303.787848486056;5320.627556071072;5203.138273949332;5213.592330070878;5230.692326918271;5237.607179461546;5255.185446255827;4163.854265100722;4164.895877603054;4170.562090980449;4173.207090652774;4181.916361672765;3996.8201430935533;4132.152908653734;4173.102782901676;4193.874183774492;4197.979010104945;4153.356229784388;4153.501579810427;4156.693035365371;4165;4192.9790351048205;4154.439150714676;4165.541790403038;4172.290710579209;4177.143685544472;4195.370694395865;3749.2501499699897;3749.906252343686;3763.397856342972;3766.9058273543105;3769.038895081764;4983.202687570008;5072.873178170538;5076.6192535559985;5090.363704536933;5103.106956282636;4726;4741.170295198326;4742;4746.5490778376;4756.66703330767;5434.184872269152;5445.114089532554;5449.618526703132;5477.287952566141;5517.36550296717;3905.628965248325;4059.89850253746;4070.450489183952;4084.7344922579937;4087.4890638670167;5670.829875103712;5702.173184888168;5708.571857110734;5716.1997320375185;5727.742251598646;4163.500379954365;4171.937420938689;4206.831726730958;4207.453031105937;4207.663386929038;4015.297322968469;4145.626893579592;4173.582641735802;4183.811728472226;4253.659707223414;4669.41632295963;4676.883077923079;4686.297055441711;4699.436067671902;4711.104890070876;5454.14559049917;5465.535429488538;5480.561555075585;5486;5539.9169012464845;1281.6475469246031;1361.9591412257648;1370.7451242705692;1394.4422231107435;1400.1738974005386;912.2975309012023;928.3779867488664;928.4197376639601;971.8056388722284;972.5817898303656;4722.456917454468;4772.5943294819635;4772.809087636456;4782.067496838084;4786.7845946932475;5024.62315326352;5041.7227052511735;5044.571211446994;5044.772985215601;5053.595712343077;5039.622028347889;5391.676499410048;5403.973245083422;5452.672839629635;5468.535174510132;3011.728944395015;3028.9545656815167;3040.3463255400197;3048.9542656860167;3058.5412188171954;5736.368999410061;5826.854328641733;5864.67744274069;5906.734196961061;5925.4370834770625;5730.1404789281105;5732.369439361667;5779.942200578024;5783.975608536978;5804.100364443518;5827.79602713903;5831.562632802556;5839.328477225174;5845.707714614337;5848.017511069385;5436.972815135899;5630.352509461464;5658.122990936411;5662.688552129673;5682.3465301489205;5621.5221706155435;5648.661080335193;5649.71751412436;5655.4344565543115;5683.2895888014;5657.349404818498;5746.281714785652;5806.2581225632985;5815.302163740378;5842.795502157404;3804.410316400962;3943.6253555912144;4039.3738970459626;4049.7040946897887;4053.493313335833;5521.791283486637;5563.833085007456;5585.2180694701965;5594.125967800832;5594.636348637326;5484.369297530835;5484.670919744828;5488.533474654699;5490.780368785204;5498.5876059294915;5331.173668081454;5411.891762164656;5418.918716219181;5420.566354691537;5471.644343117685;5381.408045114956;5382.703951282717;5402.216678581663;5427.6472029317965;5428.7285635718845;5498.505134537911;5527.198556209247;5537.944620553904;5551.861203469945;5571.498565129158;5185.844424667266;5384.515393614593;5452.700101494456;5454.4272851351625;5460.535854452416 11:21:39 INFO - PROCESS | 27980 | |5;yui.html;705.3440300520514;712.6650474277089;768.2893323675598;835.5613303015912;845.2984023260694;14591.124532528056;15427.228638568084;15435.459758908426;15440.845591544066;15444.073355598672;14885.404583816635;15107.77338339923;15124;15129.6974060519;15129.6974060519;658.6212927566669;772.2702046565997;779.9649015794274;803.6544285957036;813.6013353456793;797.57728403946;807.3944541593804;807.5437377881508;808.0545761459077;808.1918081918081;851.5444237333028;852.957352132394;853.3088198559155;853.4537895746727;853.5348235211793;678.9762358317436;830.5099991005336;843.9451435656663;847.8982522097357;852.9872051919226;609.2780055634088;609.4788955443076;616.0451300484232;617.5831313863124;618.7184830901929;14414.92792536041;14418.495352662607;14434.855651443457;14450.277486125651;14467.565973020826;15203.087814731152;15432.11726970238;15512.767308490269;15678.451254206047;15687.764683529756;12285.201461905037;12504.187227830162;12636.30500322482;12677.74644507114;13233.139845909986;3944.777089337887;3949.9605003949882;3979.46277252573;4153.376993450976;4158.022864626811;73072;73194;73314.99999999946;74022.62988685022;75750.62124689396;10993.845646207194;11113;11122.22144449897;11219.495122719498;11419.60031398897;21268;21270.680939785914;21295.78704212969;21297.893510532347;21306.254281100086;7865.882011769828;8420.284275836622;8437.198466145706;8478.57607119654;8610.182032706884;4352.521222665504;4567.885802854888;4611.262198048296;4735.59747421473;4863.781129849165;3405.0976491229844;3527.188746588248;3535.080878971486;3535.381308271042;3542.9645703542633;644.3620815392821;652.5660435810228;660.7720336483906;667.0960848050918;669.0800149794034;606.1211243696657;607.6900780601925;616.6793267500964;621.2948303675271;626.9968650156811;9531.952340238393;9628.75928101803;9911.553980070914;9965.152961998312;10351.63769268072;556.919246709233;617.3826173826174;640.6252342379667;675.2167485716545;699.832040310332;4425.690201685851;4766.475687674353;4827.662063655511;4827.847294173931;4850.781714822841;109509.45245273723;115071.42464287626;115195;116745;121039;93886;97625;97919.51040244896;97930;98827.50586247166;51525.7423712879;74435.62782186054;76324.23675763283;84078.5796071028;85297;9992.500374981368;10265.384076955406;10398.55633926042;10467.633632822815;10921.672349829518;53359.73320133374;54276.45723542714;54877;55242.72378638081;55635;50634.49365506298;60459.39540604714;65126;66260;75295;11651.766964660828;11993.280403175837;12170.208936419105;12172;12533.373331333214;14725.631859203177;14993.850061499681;15472.5358239253;15811.367545298059;15949.202539873191;14109.22399268009;14274.857251427768;14789.556313310617;14909.478168264059;15389.846101538842;13065.216087034809;13166.210027398387;14313.069650472686;14351.282435878373;14810.333534990736;12595.748085038065;13114.475420983053;13280.417775267442;13394.397252123483;13421.530246441327;10983.340999540053;11337.26307789991;11400.372979486208;11411.885881141083;11741.530338786353;10693.304935179189;11522.161838759803;11673.883261167279;11892.702682432662;11986.220895641756 11:21:39 INFO - PROCESS | 27980 | __end_tp_report 11:21:39 INFO - PROCESS | 27980 | __start_cc_report 11:21:39 INFO - PROCESS | 27980 | _x_x_mozilla_cycle_collect,982 11:21:39 INFO - PROCESS | 27980 | __end_cc_report 11:21:39 INFO - PROCESS | 27980 | __startTimestamp1469470899007__endTimestamp 11:21:39 INFO - PROCESS | 27980 | 11:21:39 INFO - PROCESS | 27980 | ------- Summary: start ------- 11:21:39 INFO - PROCESS | 27980 | Number of tests: 6 11:21:39 INFO - PROCESS | 27980 | 11:21:39 INFO - PROCESS | 27980 | [#0] dojo.html Cycles:165 Average:5366.79 Median:5584.69 stddev:607.44 (10.9%) stddev-sans-first:582.01 11:21:39 INFO - PROCESS | 27980 | Values: 3071.6 3072.9 3097.1 3109.5 3150.0 5246.1 5330.8 5336.7 5431.3 5446.3 5355.5 5364.8 5383.3 5409.9 5474.2 4920.8 4944.3 4959.1 4973.6 5108.8 5011.0 5029.1 5030.6 5034.0 5035.7 4811.5 4856.5 4866.9 4880.5 4929.0 4824.1 4930.0 4938.3 4941.7 4943.3 4846.6 4846.7 4853.1 4895.5 4927.4 5403.8 5405.2 5449.4 5456.9 5465.9 5640.2 5804.3 5817.0 5822.5 5871.5 5662.4 5704.4 5706.5 5752.1 5788.9 5374.8 5401.4 5402.4 5406.8 5415.9 5776.5 5779.0 5954.6 5961.1 5961.9 5583.8 5591.0 5604.4 5640.7 5645.4 5682.7 5684.2 5730.4 5738.7 5751.2 5557.1 5660.3 5679.4 5685.3 5686.8 5733.9 5764.9 5776.1 5818.7 5830.4 4368.5 4404.9 4412.0 4412.9 4447.2 3883.7 3895.6 3953.7 3959.5 3979.0 5471.3 5511.1 5512.2 5517.5 5565.0 5834.5 5841.4 5851.0 5853.9 5890.9 5348.5 5433.7 5520.2 5524.4 5526.2 5027.3 5031.3 5035.1 5066.4 5075.4 5897.9 5919.9 5922.8 5927.3 5929.2 5498.7 5721.0 5753.1 5776.1 5778.0 5987.6 5993.4 6010.8 6052.2 6054.8 5737.7 5748.6 5760.2 5760.8 5777.9 5613.1 5722.7 5860.2 5879.3 5881.4 5609.7 5663.9 5669.8 5676.1 5714.5 5613.3 5639.9 5649.9 5664.9 5666.2 5292.3 5508.2 5614.1 5617.2 5623.9 5591.9 5745.5 5752.5 5753.0 5765.0 5580.2 5584.2 5584.7 5585.5 5586.6 11:21:39 INFO - PROCESS | 27980 | 11:21:39 INFO - PROCESS | 27980 | [#1] ext.html Cycles:180 Average:63869.05 Median:44297.06 stddev:126419.70 (285.4%) stddev-sans-first:126685.09 11:21:39 INFO - PROCESS | 27980 | Values: 599.8 613.4 618.9 621.9 639.2 44063.3 45805.8 45823.1 45962.5 49350.5 47559.0 47898.8 47953.8 47962.0 48006.8 9048.4 9196.7 9198.0 9203.2 9207.2 8877.4 8947.6 8958.4 8968.7 8971.6 8982.9 9011.0 9018.7 9024.5 9031.5 8979.7 9013.9 9015.6 9017.3 9017.6 9030.9 9032.8 9086.0 9093.0 9099.0 44284.8 44606.8 44766.8 44778.8 44837.8 3456.4 3456.8 3474.3 3656.9 3770.2 33491.7 33499.5 33777.0 33791.0 35247.6 4412.8 4467.5 4536.8 4537.4 4587.6 390664.3 392106.0 392243.2 392604.0 392657.0 52785.0 59790.0 60287.0 60317.4 63693.0 63985.4 64264.7 64695.0 64985.7 65083.3 16688.1 16784.7 16936.7 16943.4 16946.2 12595.8 12753.9 12794.3 12800.8 12831.7 15527.0 17115.2 17651.2 17655.1 17899.8 5925.7 5981.8 5988.2 5988.6 6054.7 943.2 1005.4 1054.9 1103.8 1177.7 32702.0 33015.5 33155.0 33222.5 33273.7 1115.3 1117.7 1152.9 1226.9 1248.1 16736.5 17179.6 17228.7 17247.1 17383.7 563969.0 566055.0 567094.0 569018.0 571226.0 60226.7 60660.4 60687.0 60703.0 60718.0 1310.2 1373.2 1393.2 1400.2 1402.0 31422.7 31898.2 31931.4 32803.6 32932.5 54269.0 54503.5 54673.0 54698.5 54737.7 452238.0 452714.0 454912.0 455053.0 455060.0 32371.7 43087.4 43637.8 43970.6 44309.3 48296.3 48699.0 48729.3 48911.8 48974.5 40670.4 42205.2 42310.6 42452.0 44046.8 41387.2 41592.0 41702.8 42619.0 43146.8 40571.8 41767.2 41939.2 42382.6 42704.6 33739.7 36706.3 36850.6 36907.1 38003.2 28124.2 28144.4 28298.0 28379.9 28445.1 11:21:39 INFO - PROCESS | 27980 | 11:21:39 INFO - PROCESS | 27980 | [#2] jquery.html Cycles:180 Average:30382.69 Median:1689.89 stddev:90406.94 (5349.9%) stddev-sans-first:90632.46 11:21:39 INFO - PROCESS | 27980 | Values: 367.3 381.4 385.8 397.5 418.9 14356.4 16443.8 18967.4 19535.7 19541.6 18489.0 18651.3 18734.3 18771.9 19020.9 4099.4 5438.7 5628.9 5632.0 5632.8 6025.3 6257.7 6332.7 6392.7 6394.5 6114.2 6232.0 6279.4 6348.3 6356.0 6234.6 6266.0 6269.7 6273.3 6276.7 5409.8 5578.3 5626.7 5628.1 5634.5 22672.7 23111.9 23123.0 23140.3 23375.9 2437.6 2458.6 2460.2 2544.3 3012.5 13720.2 14353.6 14461.6 15039.8 15094.1 1845.2 1873.8 1909.8 1960.3 2010.6 80125.2 81263.0 82354.6 83273.2 83314.0 10122.5 10213.9 10316.0 10357.4 10559.8 14494.9 14494.9 14496.1 14510.1 14510.3 7372.0 7525.7 7616.9 7653.3 7945.2 7353.7 7460.0 7634.1 7650.5 7653.3 6261.4 6476.5 6479.8 6489.1 6635.4 1831.3 1875.0 1878.1 1899.4 1961.7 956.0 974.2 978.2 994.1 1024.7 19554.8 19907.8 19971.6 20043.5 20197.3 1040.7 1048.8 1052.5 1054.5 1076.1 10562.7 10948.1 11036.9 11368.0 11370.8 549329.0 550653.0 550813.0 551015.0 556588.0 78412.0 79229.6 79499.0 80106.0 83414.0 953.1 979.7 989.7 990.5 998.1 17002.3 17128.1 17416.2 17442.4 17889.4 40496.8 40619.4 41000.4 41387.6 42664.0 52347.0 53431.0 53450.0 53891.2 54005.9 8199.2 8345.3 8373.6 8529.8 8611.5 12342.6 12971.6 12983.9 13030.9 13151.7 11332.3 11433.4 11604.7 11713.8 12009.8 11335.5 11539.1 11620.6 11681.9 12025.8 11578.2 11705.8 12164.9 12200.9 12275.4 8296.8 8538.0 8574.4 8580.2 8659.7 11545.7 11549.7 11731.8 11782.2 12070.6 11:21:39 INFO - PROCESS | 27980 | 11:21:39 INFO - PROCESS | 27980 | [#3] mootools.html Cycles:180 Average:5753.58 Median:5075.78 stddev:3287.99 (64.8%) stddev-sans-first:3280.49 11:21:39 INFO - PROCESS | 27980 | Values: 1341.0 1427.8 1483.9 1574.1 1758.4 8305.4 8645.0 8689.0 8854.5 8856.6 8754.2 8773.7 8781.0 8794.4 8853.4 2344.4 2369.1 2370.0 2370.3 2374.3 2329.5 2340.4 2395.9 2399.4 2400.3 2350.9 2352.4 2382.7 2384.3 2385.9 2267.7 2310.0 2318.8 2326.8 2347.1 2297.2 2327.6 2327.8 2333.9 2335.1 8865.2 8868.1 8924.4 8942.2 8981.1 5093.5 5153.8 5193.6 5199.7 5209.3 3277.1 3337.0 3337.8 3400.8 3409.7 1195.4 1200.2 1203.9 1213.1 1216.9 11939.2 11965.2 12017.1 12023.6 12037.5 4127.7 4291.9 4394.2 4436.6 4436.7 9550.8 9575.9 9577.4 9581.9 9581.9 5065.6 5068.4 5074.7 5076.9 5078.4 4196.1 4633.1 4699.4 4744.1 4763.2 3654.0 3767.5 3824.5 3839.9 3840.8 1086.8 1169.2 1169.9 1171.0 1187.8 917.7 926.6 928.6 959.0 980.9 5525.4 5587.3 5736.4 5913.5 6109.7 908.0 909.1 914.4 924.3 964.3 3743.8 3870.2 3875.7 3933.3 3938.3 10629.8 11166.7 11179.1 11180.7 11182.2 10785.7 11075.7 11130.9 11135.9 11166.8 8197.7 8453.8 8457.7 8464.2 8470.2 5623.0 5623.7 5653.9 5706.3 5882.0 9878.6 10024.6 10070.2 10271.2 10282.5 9990.8 10052.6 10197.5 10321.1 10408.3 7206.3 7333.2 7532.7 8082.6 8189.3 8516.3 8721.2 8783.0 8789.3 8826.8 7697.6 7719.5 7849.8 7898.8 7935.7 7204.8 7523.6 7634.2 7640.9 7645.2 6792.1 6874.0 6874.7 6877.1 6879.9 5115.7 5145.0 5178.8 5215.1 5334.2 5245.3 5332.0 5353.7 5386.8 5572.7 11:21:39 INFO - PROCESS | 27980 | 11:21:39 INFO - PROCESS | 27980 | [#4] prototype.html Cycles:180 Average:4626.23 Median:5234.15 stddev:1339.17 (25.6%) stddev-sans-first:1303.53 11:21:39 INFO - PROCESS | 27980 | Values: 330.1 331.1 337.2 342.6 347.4 5105.3 5246.6 5295.5 5303.8 5320.6 5203.1 5213.6 5230.7 5237.6 5255.2 4163.9 4164.9 4170.6 4173.2 4181.9 3996.8 4132.2 4173.1 4193.9 4198.0 4153.4 4153.5 4156.7 4165.0 4193.0 4154.4 4165.5 4172.3 4177.1 4195.4 3749.3 3749.9 3763.4 3766.9 3769.0 4983.2 5072.9 5076.6 5090.4 5103.1 4726.0 4741.2 4742.0 4746.5 4756.7 5434.2 5445.1 5449.6 5477.3 5517.4 3905.6 4059.9 4070.5 4084.7 4087.5 5670.8 5702.2 5708.6 5716.2 5727.7 4163.5 4171.9 4206.8 4207.5 4207.7 4015.3 4145.6 4173.6 4183.8 4253.7 4669.4 4676.9 4686.3 4699.4 4711.1 5454.1 5465.5 5480.6 5486.0 5539.9 1281.6 1362.0 1370.7 1394.4 1400.2 912.3 928.4 928.4 971.8 972.6 4722.5 4772.6 4772.8 4782.1 4786.8 5024.6 5041.7 5044.6 5044.8 5053.6 5039.6 5391.7 5404.0 5452.7 5468.5 3011.7 3029.0 3040.3 3049.0 3058.5 5736.4 5826.9 5864.7 5906.7 5925.4 5730.1 5732.4 5779.9 5784.0 5804.1 5827.8 5831.6 5839.3 5845.7 5848.0 5437.0 5630.4 5658.1 5662.7 5682.3 5621.5 5648.7 5649.7 5655.4 5683.3 5657.3 5746.3 5806.3 5815.3 5842.8 3804.4 3943.6 4039.4 4049.7 4053.5 5521.8 5563.8 5585.2 5594.1 5594.6 5484.4 5484.7 5488.5 5490.8 5498.6 5331.2 5411.9 5418.9 5420.6 5471.6 5381.4 5382.7 5402.2 5427.6 5428.7 5498.5 5527.2 5537.9 5551.9 5571.5 5185.8 5384.5 5452.7 5454.4 5460.5 11:21:39 INFO - PROCESS | 27980 | 11:21:39 INFO - PROCESS | 27980 | [#5] yui.html Cycles:180 Average:20247.63 Median:4389.11 stddev:28712.57 (654.2%) stddev-sans-first:28755.62 11:21:39 INFO - PROCESS | 27980 | Values: 705.3 712.7 768.3 835.6 845.3 14591.1 15427.2 15435.5 15440.8 15444.1 14885.4 15107.8 15124.0 15129.7 15129.7 658.6 772.3 780.0 803.7 813.6 797.6 807.4 807.5 808.1 808.2 851.5 853.0 853.3 853.5 853.5 679.0 830.5 843.9 847.9 853.0 609.3 609.5 616.0 617.6 618.7 14414.9 14418.5 14434.9 14450.3 14467.6 15203.1 15432.1 15512.8 15678.5 15687.8 12285.2 12504.2 12636.3 12677.7 13233.1 3944.8 3950.0 3979.5 4153.4 4158.0 73072.0 73194.0 73315.0 74022.6 75750.6 10993.8 11113.0 11122.2 11219.5 11419.6 21268.0 21270.7 21295.8 21297.9 21306.3 7865.9 8420.3 8437.2 8478.6 8610.2 4352.5 4567.9 4611.3 4735.6 4863.8 3405.1 3527.2 3535.1 3535.4 3543.0 644.4 652.6 660.8 667.1 669.1 606.1 607.7 616.7 621.3 627.0 9532.0 9628.8 9911.6 9965.2 10351.6 556.9 617.4 640.6 675.2 699.8 4425.7 4766.5 4827.7 4827.8 4850.8 109509.5 115071.4 115195.0 116745.0 121039.0 93886.0 97625.0 97919.5 97930.0 98827.5 51525.7 74435.6 76324.2 84078.6 85297.0 9992.5 10265.4 10398.6 10467.6 10921.7 53359.7 54276.5 54877.0 55242.7 55635.0 50634.5 60459.4 65126.0 66260.0 75295.0 11651.8 11993.3 12170.2 12172.0 12533.4 14725.6 14993.9 15472.5 15811.4 15949.2 14109.2 14274.9 14789.6 14909.5 15389.8 13065.2 13166.2 14313.1 14351.3 14810.3 12595.7 13114.5 13280.4 13394.4 13421.5 10983.3 11337.3 11400.4 11411.9 11741.5 10693.3 11522.2 11673.9 11892.7 11986.2 11:21:39 INFO - PROCESS | 27980 | -------- Summary: end -------- 11:21:39 INFO - PROCESS | 27980 | 11:21:39 INFO - TEST-INFO | 27980: exit 0 11:21:39 INFO - TEST-OK | dromaeo_css | took 1113479ms 11:21:39 INFO - TEST-START | kraken 11:21:39 INFO - operating with platform_type : linux_ 11:21:39 INFO - Initialising browser for kraken test... 11:21:39 INFO - TEST-INFO | started process 28170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjsvS_i/profile http://localhost:52049/getInfo.html) 11:21:42 INFO - PROCESS | 28170 | JavaScript error: , line 0: uncaught exception: undefined 11:21:43 INFO - PROCESS | 28170 | __metrics Screen width/height:1600/1200 11:21:43 INFO - PROCESS | 28170 | colorDepth:24 11:21:43 INFO - PROCESS | 28170 | Browser inner width/height: 1024/697 11:21:43 INFO - PROCESS | 28170 | __metrics 11:21:44 INFO - PROCESS | 28170 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:21:44 INFO - PROCESS | 28170 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:45 INFO - TEST-INFO | 28170: exit 0 11:21:45 INFO - Browser initialized. 11:21:45 INFO - Running cycle 1/1 for kraken test... 11:21:45 INFO - TEST-INFO | started process 28250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjsvS_i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:57 INFO - PROCESS | 28250 | RSS: Main: 157937664 11:21:57 INFO - PROCESS | 28250 | 11:21:59 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52049/tests/kraken/driver.html?testName=audio-beat-detection) 11:22:00 INFO - PROCESS | 28250 | RSS: Main: 214290432 11:22:00 INFO - PROCESS | 28250 | 11:22:03 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52049/tests/kraken/driver.html?testName=audio-dft) 11:22:03 INFO - PROCESS | 28250 | RSS: Main: 192843776 11:22:03 INFO - PROCESS | 28250 | 11:22:06 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52049/tests/kraken/driver.html?testName=audio-fft) 11:22:07 INFO - PROCESS | 28250 | RSS: Main: 270475264 11:22:07 INFO - PROCESS | 28250 | 11:22:09 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52049/tests/kraken/driver.html?testName=audio-oscillator) 11:22:09 INFO - PROCESS | 28250 | RSS: Main: 181338112 11:22:09 INFO - PROCESS | 28250 | 11:22:12 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52049/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:22:12 INFO - PROCESS | 28250 | RSS: Main: 185831424 11:22:12 INFO - PROCESS | 28250 | 11:22:15 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52049/tests/kraken/driver.html?testName=imaging-darkroom) 11:22:16 INFO - PROCESS | 28250 | RSS: Main: 221761536 11:22:16 INFO - PROCESS | 28250 | 11:22:19 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52049/tests/kraken/driver.html?testName=imaging-desaturate) 11:22:20 INFO - PROCESS | 28250 | RSS: Main: 221728768 11:22:20 INFO - PROCESS | 28250 | 11:22:22 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52049/tests/kraken/driver.html?testName=json-parse-financial) 11:22:23 INFO - PROCESS | 28250 | RSS: Main: 221052928 11:22:23 INFO - PROCESS | 28250 | 11:22:25 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52049/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:22:25 INFO - PROCESS | 28250 | RSS: Main: 185298944 11:22:25 INFO - PROCESS | 28250 | 11:22:27 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:22:28 INFO - PROCESS | 28250 | RSS: Main: 189476864 11:22:28 INFO - PROCESS | 28250 | 11:22:30 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:22:30 INFO - PROCESS | 28250 | RSS: Main: 195858432 11:22:30 INFO - PROCESS | 28250 | 11:22:33 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:22:33 INFO - PROCESS | 28250 | RSS: Main: 189411328 11:22:33 INFO - PROCESS | 28250 | 11:22:36 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:22:37 INFO - PROCESS | 28250 | RSS: Main: 194359296 11:22:37 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | Cycle 1(1): loaded http://localhost:52049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52049/tests/kraken/driver.html?testName=ai-astar) 11:22:38 INFO - PROCESS | 28250 | RSS: Main: 245211136 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | __start_tp_report 11:22:38 INFO - PROCESS | 28250 | _x_x_mozilla_page_load 11:22:38 INFO - PROCESS | 28250 | _x_x_mozilla_page_load_details 11:22:38 INFO - PROCESS | 28250 | |i|pagename|runs| 11:22:38 INFO - PROCESS | 28250 | |0;ai-astar;102;112;110;110;111;110;110;109;109;109 11:22:38 INFO - PROCESS | 28250 | |1;audio-beat-detection;149;117;122;182;119;118;153;122;160;117 11:22:38 INFO - PROCESS | 28250 | |2;audio-dft;161;160;161;160;162;160;162;162;161;160 11:22:38 INFO - PROCESS | 28250 | |3;audio-fft;74;74;75;133;74;75;74;75;105;74 11:22:38 INFO - PROCESS | 28250 | |4;audio-oscillator;83;84;111;83;83;84;121;83;83;123 11:22:38 INFO - PROCESS | 28250 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;116 11:22:38 INFO - PROCESS | 28250 | |6;imaging-darkroom;146;147;146;147;146;146;148;146;146;146 11:22:38 INFO - PROCESS | 28250 | |7;imaging-desaturate;95;95;95;96;95;96;95;95;96;95 11:22:38 INFO - PROCESS | 28250 | |8;json-parse-financial;51;50;51;51;51;51;61;50;50;52 11:22:38 INFO - PROCESS | 28250 | |9;json-stringify-tinderbox;62;61;61;62;62;61;62;62;62;61 11:22:38 INFO - PROCESS | 28250 | |10;stanford-crypto-aes;77;86;76;80;76;77;74;75;76;80 11:22:38 INFO - PROCESS | 28250 | |11;stanford-crypto-ccm;128;119;121;131;130;119;121;118;169;130 11:22:38 INFO - PROCESS | 28250 | |12;stanford-crypto-pbkdf2;158;163;153;155;153;154;154;153;155;154 11:22:38 INFO - PROCESS | 28250 | |13;stanford-crypto-sha256-iterative;64;63;63;63;63;62;62;64;60;62 11:22:38 INFO - PROCESS | 28250 | __end_tp_report 11:22:38 INFO - PROCESS | 28250 | __start_cc_report 11:22:38 INFO - PROCESS | 28250 | _x_x_mozilla_cycle_collect,1669 11:22:38 INFO - PROCESS | 28250 | __end_cc_report 11:22:38 INFO - PROCESS | 28250 | __startTimestamp1469470958978__endTimestamp 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | ------- Summary: start ------- 11:22:38 INFO - PROCESS | 28250 | Number of tests: 14 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.70 (2.5%) stddev-sans-first:1.00 11:22:38 INFO - PROCESS | 28250 | Values: 102.0 112.0 110.0 110.0 111.0 110.0 110.0 109.0 109.0 109.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:135.50 stddev:23.28 (17.2%) stddev-sans-first:24.20 11:22:38 INFO - PROCESS | 28250 | Values: 149.0 117.0 122.0 182.0 119.0 118.0 153.0 122.0 160.0 117.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 11:22:38 INFO - PROCESS | 28250 | Values: 161.0 160.0 161.0 160.0 162.0 160.0 162.0 162.0 161.0 160.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#3] audio-fft Cycles:10 Average:83.30 Median:74.00 stddev:19.94 (27.0%) stddev-sans-first:20.87 11:22:38 INFO - PROCESS | 28250 | Values: 74.0 74.0 75.0 133.0 74.0 75.0 74.0 75.0 105.0 74.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:83.00 stddev:17.20 (20.7%) stddev-sans-first:17.80 11:22:38 INFO - PROCESS | 28250 | Values: 83.0 84.0 111.0 83.0 83.0 84.0 121.0 83.0 83.0 123.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:22:38 INFO - PROCESS | 28250 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 11:22:38 INFO - PROCESS | 28250 | Values: 146.0 147.0 146.0 147.0 146.0 146.0 148.0 146.0 146.0 146.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:22:38 INFO - PROCESS | 28250 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:51.00 stddev:3.29 (6.5%) stddev-sans-first:3.48 11:22:38 INFO - PROCESS | 28250 | Values: 51.0 50.0 51.0 51.0 51.0 51.0 61.0 50.0 50.0 52.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 11:22:38 INFO - PROCESS | 28250 | Values: 62.0 61.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 61.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.00 stddev:3.50 (4.5%) stddev-sans-first:3.70 11:22:38 INFO - PROCESS | 28250 | Values: 77.0 86.0 76.0 80.0 76.0 77.0 74.0 75.0 76.0 80.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:129.00 stddev:15.11 (11.7%) stddev-sans-first:16.02 11:22:38 INFO - PROCESS | 28250 | Values: 128.0 119.0 121.0 131.0 130.0 119.0 121.0 118.0 169.0 130.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:154.50 stddev:3.12 (2.0%) stddev-sans-first:3.14 11:22:38 INFO - PROCESS | 28250 | Values: 158.0 163.0 153.0 155.0 153.0 154.0 154.0 153.0 155.0 154.0 11:22:38 INFO - PROCESS | 28250 | 11:22:38 INFO - PROCESS | 28250 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.17 (1.9%) stddev-sans-first:1.13 11:22:38 INFO - PROCESS | 28250 | Values: 64.0 63.0 63.0 63.0 63.0 62.0 62.0 64.0 60.0 62.0 11:22:38 INFO - PROCESS | 28250 | -------- Summary: end -------- 11:22:38 INFO - PROCESS | 28250 | 11:22:39 INFO - TEST-INFO | 28250: exit 0 11:22:40 INFO - TEST-OK | kraken | took 60318ms 11:22:40 INFO - SUITE-END | took 1173s 11:22:40 INFO - Completed test suite (00:19:33) 11:22:40 INFO - javascript benchmark 11:22:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.5853359796433, 3072.9231769205767, 3097.086359523943, 3109.486934655782, 3150.0, 5246.108161612526, 5330.813421530247, 5336.733163341837, 5431.293931788867, 5446.319210098738, 5355.4912283333115, 5364.812231571896, 5383.273258110154, 5409.918851217235, 5474.151506516487, 4920.8031678732805, 4944.332515110468, 4959.132151873426, 4973.552380285773, 5108.795648174068, 5011.0, 5029.069622119901, 5030.647854650176, 5034.0, 5035.672681275705, 4811.542903424169, 4856.490068542787, 4866.878328041792, 4880.536349046835, 4928.999999999982, 4824.107540105057, 4930.03864246472, 4938.2839488274, 4941.654084214107, 4943.2585112233455, 4846.563809257149, 4846.660733748639, 4853.102176097434, 4895.534924182197, 4927.384076990376, 5403.756830942617, 5405.18922161675, 5449.427810079924, 5456.863578410572, 5465.863353416156, 5640.238567793336, 5804.303483581997, 5816.97091514544, 5822.505087067604, 5871.500922421599, 5662.433756624346, 5704.429557044304, 5706.4864162225595, 5752.108423194411, 5788.913166302466, 5374.811881584164, 5401.351837779453, 5402.405735369146, 5406.783728650849, 5415.891682166334, 5776.537876969833, 5779.0, 5954.55340849438, 5961.135635332853, 5961.880762384815, 5583.776648934078, 5590.972045139748, 5604.355499117653, 5640.746166422438, 5645.350784659817, 5682.715864206773, 5684.175794509773, 5730.426957304237, 5738.713064346766, 5751.194832723422, 5557.055300598908, 5660.349059858169, 5679.375268720438, 5685.346185188673, 5686.800961966312, 5733.856653583611, 5764.855878603068, 5776.104703770922, 5818.650880947157, 5830.416958304136, 4368.475782906008, 4404.911901761947, 4411.977940110343, 4412.933805992912, 4447.155040542287, 3883.708721845873, 3895.6104389561383, 3953.683705303569, 3959.544652364957, 3978.980105099514, 5471.261379713767, 5511.118221084687, 5512.228288039678, 5517.531009864127, 5564.972175139098, 5834.474897259267, 5841.357450680422, 5850.970745146247, 5853.9414605854245, 5890.911636325459, 5348.545373643206, 5433.673979561239, 5520.199571062173, 5524.4199359067525, 5526.171074338881, 5027.296178535008, 5031.295618613397, 5035.093683137071, 5066.442691303953, 5075.441701412841, 5897.882042359129, 5919.940800591939, 5922.763089476459, 5927.31835838884, 5929.229200203946, 5498.670079795225, 5720.971395142998, 5753.05074662676, 5776.075827867521, 5777.971110144591, 5987.550933679904, 5993.430624090704, 6010.849728756816, 6052.243469566304, 6054.788082417094, 5737.713114344183, 5748.568857335633, 5760.1935728998815, 5760.8271751847515, 5777.9133313001175, 5613.129964855454, 5722.74247658848, 5860.208871802422, 5879.265091863517, 5881.441263080001, 5609.747561359667, 5663.915041274302, 5669.773209071591, 5676.091825307931, 5714.457126572969, 5613.270274864241, 5639.915401269066, 5649.887002260014, 5664.886702265849, 5666.15007748841, 5292.311999440049, 5508.228847961369, 5614.101743720985, 5617.213590097472, 5623.8875222496135, 5591.8881622368135, 5745.540356771365, 5752.453516915886, 5752.9712351437975, 5765.019946609003, 5580.190872323409, 5584.190292407659, 5584.692841893735, 5585.497305242548, 5586.608937374344], "value": 5325.591113268892, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.8290487211144, 613.435639211925, 618.8669436071245, 621.8507558186037, 639.2265358915712, 44063.33904991423, 45805.77097114518, 45823.08353832926, 45962.54037459625, 49350.50649493504, 47559.0, 47898.760506197505, 47953.76023119888, 47962.0407591848, 48006.75996620012, 9048.411853229536, 9196.678116265932, 9198.0, 9203.17171454569, 9207.217386522154, 8877.378583499158, 8947.64209431622, 8958.417702849294, 8968.730938071836, 8971.641134354619, 8982.865257021118, 9011.0, 9018.729438116867, 9024.458532488039, 9031.548422578844, 8979.742836002932, 9013.909860901373, 9015.594298256594, 9017.323700722407, 9017.639294428214, 9030.909690903138, 9032.77418064547, 9085.954570227173, 9092.954535227347, 9098.954505227432, 44284.77857610691, 44606.776966115285, 44766.77616611896, 44778.776106119585, 44837.775811121064, 3456.4469684850555, 3456.7580269381156, 3474.2877710069374, 3656.9085772855624, 3770.2082562661876, 33491.6650833491, 33499.49750753741, 33777.0, 33791.0, 35247.64752352469, 4412.84555040572, 4467.486239082515, 4536.7504787236685, 4537.387452693877, 4587.610053145487, 390664.2800715983, 392106.0, 392243.15513689566, 392603.99999999715, 392657.0, 52785.0, 59790.0, 60287.0, 60317.39682603118, 63693.0, 63985.360146398874, 64264.678676606316, 64695.0, 64985.67507162529, 65083.34916650868, 16688.082155481323, 16784.664306713796, 16936.745948810778, 16943.406980755863, 16946.23741931616, 12595.811062834066, 12753.872461275454, 12794.296313702836, 12800.80798788019, 12831.743365132645, 15527.0, 17115.22981465837, 17651.205695743723, 17655.117244137742, 17899.821001790075, 5925.703714814242, 5981.79063732776, 5988.191594134823, 5988.640681559121, 6054.727537260834, 943.155875491445, 1005.4319309590059, 1054.8628678271775, 1103.8289065194908, 1177.7232350397649, 32702.0, 33015.50476742803, 33155.0, 33222.50166247508, 33273.66726332754, 1115.286216821235, 1117.6591139702307, 1152.8558930133734, 1226.8957138643136, 1248.1138391741783, 16736.497905062624, 17179.570510737332, 17228.741568876478, 17247.137643117792, 17383.73924391135, 563969.0, 566055.0, 567094.0, 569018.0, 571226.0, 60226.69886650539, 60660.393396066356, 60687.0, 60703.0, 60718.0, 1310.1745900083076, 1373.196679942245, 1393.2337214531967, 1400.2158791076827, 1401.978970315446, 31422.685773141977, 31898.20254493656, 31931.36137277288, 32803.58092096416, 32932.50601240935, 54269.0, 54503.45496544984, 54673.0, 54698.45301547093, 54737.72631136819, 452238.0, 452714.0, 454912.0, 455053.0, 455060.0, 32371.676283237808, 43087.35368969531, 43637.78181109074, 43970.58161801132, 44309.33535997027, 48296.275555865985, 48699.0, 48729.26906096341, 48911.755441222565, 48974.51025489842, 40670.38994415027, 42205.155896882505, 42310.5768942319, 42452.0, 44046.77976610096, 41387.1722565553, 41592.0, 41702.79148604238, 42619.0, 43146.784266078466, 40571.79922163551, 41767.16465670609, 41939.16121677488, 42382.57617423786, 42704.57295427006, 33739.662603373654, 36706.26587468289, 36850.63149368579, 36907.14463529998, 38003.239935201695, 28124.156275311772, 28144.43711125807, 28298.0, 28379.86480540838, 28445.146645600664], "value": 20790.010447976623, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.28562945071843, 381.44309308409703, 385.77432202161737, 397.46937837986286, 418.8827128404046, 14356.353964071615, 16443.75334369984, 18967.430977070675, 19535.70696439551, 19541.609167816652, 18489.0, 18651.347202847905, 18734.34429794954, 18771.906140469313, 19020.904895475538, 4099.364598487239, 5438.700871452059, 5628.887422251552, 5632.0, 5632.831015069554, 6025.3372129065765, 6257.687115644199, 6332.715027823736, 6392.680365981682, 6394.520410969196, 6114.205153330061, 6231.968840155793, 6279.434850863421, 6348.269948955883, 6356.0, 6234.594751341171, 6265.96867015662, 6269.749210031593, 6273.341299163613, 6276.654783986879, 5409.756560954766, 5578.30271216098, 5626.690532020737, 5628.099504079369, 5634.521065709419, 22672.659910101363, 23111.88444057786, 23123.0, 23140.305790826304, 23375.883120584287, 2437.573424650679, 2458.5943319352286, 2460.200434858678, 2544.3257536752776, 3012.487877060905, 13720.176789392668, 14353.569392918229, 14461.638459038502, 15039.849601504064, 15094.094354338775, 1845.2250054976942, 1873.812618738129, 1909.8185672361103, 1960.3236883275247, 2010.6481365760933, 80125.19874801235, 81263.0, 82354.58822705908, 83273.16726832776, 83314.0, 10122.54448549817, 10213.897861021444, 10316.0, 10357.4303413313, 10559.788804223872, 14494.85505144935, 14494.927525362305, 14496.130232185891, 14510.1293922365, 14510.274486275644, 7372.0, 7525.661345239478, 7616.885746713804, 7653.349465295512, 7945.205479452125, 7353.70585176587, 7459.962700186465, 7634.083909930844, 7650.4644674872225, 7653.311201991847, 6261.405166509175, 6476.514261430411, 6479.838004049842, 6489.091527186198, 6635.402813746786, 1831.2583403721515, 1875.012407440482, 1878.126671097946, 1899.43017094871, 1961.656710075731, 956.048731512136, 974.2011550528499, 978.1734434402919, 994.1202036198017, 1024.7284469615558, 19554.804451955297, 19907.800921990885, 19971.60056798856, 20043.498912527302, 20197.293094741613, 1040.6721882607105, 1048.842673598951, 1052.5211028981794, 1054.536004158168, 1076.1068313299943, 10562.683119506428, 10948.124150067975, 11036.889631103746, 11368.0, 11370.829437558443, 549329.0, 550653.0, 550813.0, 551015.0, 556588.0, 78412.0, 79229.60385198037, 79499.0, 80106.0, 83414.0, 953.113604347963, 979.7060881735451, 989.7426669066094, 990.4849478271259, 998.0668075349716, 17002.319907203575, 17128.143592820557, 17416.216270268123, 17442.389516366868, 17889.37387191442, 40496.79751601223, 40619.390709139974, 41000.38499422571, 41387.586124138375, 42664.0, 52347.0, 53431.0, 53450.0, 53891.191632126334, 54005.91988160136, 8199.22107399796, 8345.290650294794, 8373.623186956724, 8529.786755330919, 8611.526366049928, 12342.568010119603, 12971.610851674464, 12983.870161298266, 13030.869691302965, 13151.671208219872, 11332.320060796379, 11433.428328583372, 11604.6518604442, 11713.824292635447, 12009.81985270239, 11335.546578136782, 11539.134564907497, 11620.593279235187, 11681.941590291994, 12025.75948481008, 11578.189526733384, 11705.765884682429, 12164.939175304067, 12200.938995304967, 12275.447604857623, 8296.792580185544, 8538.0, 8574.442661227, 8580.184882436159, 8659.653613855375, 11545.711357215801, 11549.653510394366, 11731.824022639837, 11782.234154779911, 12070.637880863587], "value": 9356.851862830108, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.0411555737646, 1427.7786943023832, 1483.940642374305, 1574.134226175603, 1758.4021432712866, 8305.418620696546, 8645.049044605088, 8688.956555217232, 8854.513001784899, 8856.645734170641, 8754.212120909116, 8773.692920747775, 8781.0, 8794.428362156455, 8853.42452740573, 2344.3553022918663, 2369.1471070414636, 2369.9644505332435, 2370.277065495023, 2374.3114496795906, 2329.4758679297192, 2340.4031971847157, 2395.940101497459, 2399.3521749127726, 2400.327908185702, 2350.894209760565, 2352.4001379648166, 2382.702162229721, 2384.3204686664303, 2385.8687772172525, 2267.727872655292, 2309.965350519752, 2318.7913087822094, 2326.8022218111482, 2347.14329269817, 2297.2279260780306, 2327.592671282519, 2327.767223277676, 2333.871637059961, 2335.135999680112, 8865.157810008039, 8868.11318868108, 8924.375293729441, 8942.150495702897, 8981.146791054905, 5093.541581257705, 5153.768080436389, 5193.63644544882, 5199.66202196856, 5209.270702101709, 3277.147941535218, 3336.966630333714, 3337.7830441021497, 3400.795952242873, 3409.6760807723226, 1195.3545085653736, 1200.1898718365069, 1203.8615559210716, 1213.071999920062, 1216.8783121687761, 11939.223950443193, 11965.222260553037, 12017.098717596215, 12023.57917472893, 12037.518499260106, 4127.731697439657, 4291.892702682458, 4394.209042372404, 4436.556344365602, 4436.711613745097, 9550.806149231346, 9575.856362154573, 9577.377470464537, 9581.856272155923, 9581.904180958241, 5065.594752419797, 5068.4424713281505, 5074.67014644047, 5076.898462030813, 5078.415982162025, 4196.076863090116, 4633.050224703928, 4699.436067671902, 4744.122337367598, 4763.237881938873, 3653.9634603654154, 3767.547894252707, 3824.464574959508, 3839.9040023999623, 3840.7695538267235, 1086.8152414089623, 1169.2399940039043, 1169.900558452541, 1170.9590164344377, 1187.804012337972, 917.7200953709049, 926.6061923682408, 928.6424726480219, 958.9738979292091, 980.9019098090276, 5525.364583072998, 5587.329520457572, 5736.368999410145, 5913.49735272498, 6109.694515274218, 907.9863802042975, 909.1090731083575, 914.4147745442922, 924.3252425729255, 964.3105179796479, 3743.794091324949, 3870.2066076454257, 3875.6899448044087, 3933.292007438631, 3938.330483817758, 10629.787404251872, 11166.665000050012, 11179.105671546256, 11180.720481987853, 11182.21724479295, 10785.730356741144, 11075.72310692239, 11130.888691113147, 11135.944320278346, 11166.776664466664, 8197.672093116209, 8453.788655283666, 8457.746267611981, 8464.195901389236, 8470.15298470148, 5622.971885140548, 5623.690697011703, 5653.886922261614, 5706.258186435903, 5882.0, 9878.555465003948, 10024.649137280161, 10070.194384449373, 10271.229657775846, 10282.485875706334, 9990.750231244278, 10052.597896084075, 10197.54111064989, 10321.122704570196, 10408.27142100076, 7206.2793720627515, 7333.156686980852, 7532.736354227576, 8082.595870206584, 8189.344852411912, 8516.276116530164, 8721.171488708816, 8783.0, 8789.296856251613, 8826.779330516789, 7697.6151192441275, 7719.536827790126, 7849.803754906173, 7898.802529936797, 7935.722249721232, 7204.819879503054, 7523.623818809147, 7634.236576342321, 7640.923590764021, 7645.159032506531, 6792.0830687856505, 6873.965630171817, 6874.65626718652, 6877.071595334766, 6879.862402751817, 5115.667481613683, 5144.9742751286, 5178.844634660966, 5215.113430716863, 5334.226537152169, 5245.318108645852, 5331.973340133274, 5353.732313384237, 5386.811461598825, 5572.693501857437], "value": 4596.0827382290245, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.09389226573063, 331.0630914511933, 337.1604704286328, 342.5632318793538, 347.44235502019245, 5105.310783044288, 5246.580273578114, 5295.523402893738, 5303.787848486056, 5320.627556071072, 5203.138273949332, 5213.592330070878, 5230.692326918271, 5237.607179461546, 5255.185446255827, 4163.854265100722, 4164.895877603054, 4170.562090980449, 4173.207090652774, 4181.916361672765, 3996.8201430935533, 4132.152908653734, 4173.102782901676, 4193.874183774492, 4197.979010104945, 4153.356229784388, 4153.501579810427, 4156.693035365371, 4165.0, 4192.9790351048205, 4154.439150714676, 4165.541790403038, 4172.290710579209, 4177.143685544472, 4195.370694395865, 3749.2501499699897, 3749.906252343686, 3763.397856342972, 3766.9058273543105, 3769.038895081764, 4983.202687570008, 5072.873178170538, 5076.6192535559985, 5090.363704536933, 5103.106956282636, 4726.0, 4741.170295198326, 4742.0, 4746.5490778376, 4756.66703330767, 5434.184872269152, 5445.114089532554, 5449.618526703132, 5477.287952566141, 5517.36550296717, 3905.628965248325, 4059.89850253746, 4070.450489183952, 4084.7344922579937, 4087.4890638670167, 5670.829875103712, 5702.173184888168, 5708.571857110734, 5716.1997320375185, 5727.742251598646, 4163.500379954365, 4171.937420938689, 4206.831726730958, 4207.453031105937, 4207.663386929038, 4015.297322968469, 4145.626893579592, 4173.582641735802, 4183.811728472226, 4253.659707223414, 4669.41632295963, 4676.883077923079, 4686.297055441711, 4699.436067671902, 4711.104890070876, 5454.14559049917, 5465.535429488538, 5480.561555075585, 5486.0, 5539.9169012464845, 1281.6475469246031, 1361.9591412257648, 1370.7451242705692, 1394.4422231107435, 1400.1738974005386, 912.2975309012023, 928.3779867488664, 928.4197376639601, 971.8056388722284, 972.5817898303656, 4722.456917454468, 4772.5943294819635, 4772.809087636456, 4782.067496838084, 4786.7845946932475, 5024.62315326352, 5041.7227052511735, 5044.571211446994, 5044.772985215601, 5053.595712343077, 5039.622028347889, 5391.676499410048, 5403.973245083422, 5452.672839629635, 5468.535174510132, 3011.728944395015, 3028.9545656815167, 3040.3463255400197, 3048.9542656860167, 3058.5412188171954, 5736.368999410061, 5826.854328641733, 5864.67744274069, 5906.734196961061, 5925.4370834770625, 5730.1404789281105, 5732.369439361667, 5779.942200578024, 5783.975608536978, 5804.100364443518, 5827.79602713903, 5831.562632802556, 5839.328477225174, 5845.707714614337, 5848.017511069385, 5436.972815135899, 5630.352509461464, 5658.122990936411, 5662.688552129673, 5682.3465301489205, 5621.5221706155435, 5648.661080335193, 5649.71751412436, 5655.4344565543115, 5683.2895888014, 5657.349404818498, 5746.281714785652, 5806.2581225632985, 5815.302163740378, 5842.795502157404, 3804.410316400962, 3943.6253555912144, 4039.3738970459626, 4049.7040946897887, 4053.493313335833, 5521.791283486637, 5563.833085007456, 5585.2180694701965, 5594.125967800832, 5594.636348637326, 5484.369297530835, 5484.670919744828, 5488.533474654699, 5490.780368785204, 5498.5876059294915, 5331.173668081454, 5411.891762164656, 5418.918716219181, 5420.566354691537, 5471.644343117685, 5381.408045114956, 5382.703951282717, 5402.216678581663, 5427.6472029317965, 5428.7285635718845, 5498.505134537911, 5527.198556209247, 5537.944620553904, 5551.861203469945, 5571.498565129158, 5185.844424667266, 5384.515393614593, 5452.700101494456, 5454.4272851351625, 5460.535854452416], "value": 4199.92033305756, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.3440300520514, 712.6650474277089, 768.2893323675598, 835.5613303015912, 845.2984023260694, 14591.124532528056, 15427.228638568084, 15435.459758908426, 15440.845591544066, 15444.073355598672, 14885.404583816635, 15107.77338339923, 15124.0, 15129.6974060519, 15129.6974060519, 658.6212927566669, 772.2702046565997, 779.9649015794274, 803.6544285957036, 813.6013353456793, 797.57728403946, 807.3944541593804, 807.5437377881508, 808.0545761459077, 808.1918081918081, 851.5444237333028, 852.957352132394, 853.3088198559155, 853.4537895746727, 853.5348235211793, 678.9762358317436, 830.5099991005336, 843.9451435656663, 847.8982522097357, 852.9872051919226, 609.2780055634088, 609.4788955443076, 616.0451300484232, 617.5831313863124, 618.7184830901929, 14414.92792536041, 14418.495352662607, 14434.855651443457, 14450.277486125651, 14467.565973020826, 15203.087814731152, 15432.11726970238, 15512.767308490269, 15678.451254206047, 15687.764683529756, 12285.201461905037, 12504.187227830162, 12636.30500322482, 12677.74644507114, 13233.139845909986, 3944.777089337887, 3949.9605003949882, 3979.46277252573, 4153.376993450976, 4158.022864626811, 73072.0, 73194.0, 73314.99999999946, 74022.62988685022, 75750.62124689396, 10993.845646207194, 11113.0, 11122.22144449897, 11219.495122719498, 11419.60031398897, 21268.0, 21270.680939785914, 21295.78704212969, 21297.893510532347, 21306.254281100086, 7865.882011769828, 8420.284275836622, 8437.198466145706, 8478.57607119654, 8610.182032706884, 4352.521222665504, 4567.885802854888, 4611.262198048296, 4735.59747421473, 4863.781129849165, 3405.0976491229844, 3527.188746588248, 3535.080878971486, 3535.381308271042, 3542.9645703542633, 644.3620815392821, 652.5660435810228, 660.7720336483906, 667.0960848050918, 669.0800149794034, 606.1211243696657, 607.6900780601925, 616.6793267500964, 621.2948303675271, 626.9968650156811, 9531.952340238393, 9628.75928101803, 9911.553980070914, 9965.152961998312, 10351.63769268072, 556.919246709233, 617.3826173826174, 640.6252342379667, 675.2167485716545, 699.832040310332, 4425.690201685851, 4766.475687674353, 4827.662063655511, 4827.847294173931, 4850.781714822841, 109509.45245273723, 115071.42464287626, 115195.0, 116745.0, 121039.0, 93886.0, 97625.0, 97919.51040244896, 97930.0, 98827.50586247166, 51525.7423712879, 74435.62782186054, 76324.23675763283, 84078.5796071028, 85297.0, 9992.500374981368, 10265.384076955406, 10398.55633926042, 10467.633632822815, 10921.672349829518, 53359.73320133374, 54276.45723542714, 54877.0, 55242.72378638081, 55635.0, 50634.49365506298, 60459.39540604714, 65126.0, 66260.0, 75295.0, 11651.766964660828, 11993.280403175837, 12170.208936419105, 12172.0, 12533.373331333214, 14725.631859203177, 14993.850061499681, 15472.5358239253, 15811.367545298059, 15949.202539873191, 14109.22399268009, 14274.857251427768, 14789.556313310617, 14909.478168264059, 15389.846101538842, 13065.216087034809, 13166.210027398387, 14313.069650472686, 14351.282435878373, 14810.333534990736, 12595.748085038065, 13114.475420983053, 13280.417775267442, 13394.397252123483, 13421.530246441327, 10983.340999540053, 11337.26307789991, 11400.372979486208, 11411.885881141083, 11741.530338786353, 10693.304935179189, 11522.161838759803, 11673.883261167279, 11892.702682432662, 11986.220895641756], "value": 7495.343585776449, "unit": "score"}], "name": "dromaeo_css", "value": 7288.47462862912, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 109.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 122.0, 182.0, 119.0, 118.0, 153.0, 122.0, 160.0, 117.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 162.0, 160.0, 162.0, 162.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 133.0, 74.0, 75.0, 74.0, 75.0, 105.0, 74.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 111.0, 83.0, 83.0, 84.0, 121.0, 83.0, 83.0, 123.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 51.0, 51.0, 51.0, 61.0, 50.0, 50.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 86.0, 76.0, 80.0, 76.0, 77.0, 74.0, 75.0, 76.0, 80.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 119.0, 121.0, 131.0, 130.0, 119.0, 121.0, 118.0, 169.0, 130.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 163.0, 153.0, 155.0, 153.0, 154.0, 154.0, 153.0, 155.0, 154.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 64.0, 60.0, 62.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1478.9999999999998, "alertThreshold": 2.0}]} 11:22:40 INFO - Return code: 0 11:22:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:22:40 INFO - # TBPL SUCCESS # 11:22:40 INFO - Running post-action listener: _resource_record_post_action 11:22:40 INFO - [mozharness: 2016-07-25 18:22:40.272813Z] Finished run-tests step (success) 11:22:40 INFO - Running post-run listener: _resource_record_post_run 11:22:40 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556171264; Read time: 12; Write time: 453816 11:22:40 INFO - TinderboxPrint: CPU usage
13.0% 11:22:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:22:40 INFO - TinderboxPrint: I/O write bytes / time
556,171,264 / 453,816 11:22:40 INFO - TinderboxPrint: CPU idle
8,267.0 (87.0%) 11:22:40 INFO - TinderboxPrint: CPU user
1,195.5 (12.6%) 11:22:40 INFO - TinderboxPrint: Swap in / out
0 / 0 11:22:40 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257159168; Read time: 0; Write time: 253152 11:22:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 298725376; Read time: 0; Write time: 200648 11:22:40 INFO - Running post-run listener: _upload_blobber_files 11:22:40 INFO - Blob upload gear active. 11:22:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:22:40 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 11:22:40 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:22:40 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:22:41 INFO - (blobuploader) - INFO - Open directory for files ... 11:22:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:22:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:22:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:42 INFO - (blobuploader) - INFO - Done attempting. 11:22:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:22:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:23:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:05 INFO - (blobuploader) - INFO - Done attempting. 11:23:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:23:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:23:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:06 INFO - (blobuploader) - INFO - Done attempting. 11:23:06 INFO - (blobuploader) - INFO - Iteration through files over. 11:23:06 INFO - Return code: 0 11:23:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:23:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:23:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c0393f614e708a996e06315c2e0201af9c18eccabf7fd2212ca634f3fd0caca2c4f39c6a1acded627c0ce53ae400b580f9f4b1096dcd651b8b5353864601f92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1f482ff503912fbd60c60dcdb15c7cab756916e3f81fbcc8d244f3b9865f5493e04da4419c3fd74c4f3756922df8bff1ede46511b73e76718796ca243e78beb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/800ae4afa20af90940332d7eb3faae6f24e42033c9eec4dd7c2f354b1d2c21f678e3c7d2a71633cf1987bb9470aa2b262f1e871f2a0fcbebc5574d7b29bebbb8"} 11:23:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:23:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:23:06 INFO - Contents: 11:23:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c0393f614e708a996e06315c2e0201af9c18eccabf7fd2212ca634f3fd0caca2c4f39c6a1acded627c0ce53ae400b580f9f4b1096dcd651b8b5353864601f92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1f482ff503912fbd60c60dcdb15c7cab756916e3f81fbcc8d244f3b9865f5493e04da4419c3fd74c4f3756922df8bff1ede46511b73e76718796ca243e78beb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/800ae4afa20af90940332d7eb3faae6f24e42033c9eec4dd7c2f354b1d2c21f678e3c7d2a71633cf1987bb9470aa2b262f1e871f2a0fcbebc5574d7b29bebbb8"} 11:23:06 INFO - Running post-run listener: copy_logs_to_upload_dir 11:23:06 INFO - Copying logs to upload dir... 11:23:06 INFO - mkdir: /builds/slave/test/build/upload/logs 11:23:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.443396 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-25 11:23:06.186273) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 11:23:06.189876) ========= 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=ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c0393f614e708a996e06315c2e0201af9c18eccabf7fd2212ca634f3fd0caca2c4f39c6a1acded627c0ce53ae400b580f9f4b1096dcd651b8b5353864601f92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1f482ff503912fbd60c60dcdb15c7cab756916e3f81fbcc8d244f3b9865f5493e04da4419c3fd74c4f3756922df8bff1ede46511b73e76718796ca243e78beb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/800ae4afa20af90940332d7eb3faae6f24e42033c9eec4dd7c2f354b1d2c21f678e3c7d2a71633cf1987bb9470aa2b262f1e871f2a0fcbebc5574d7b29bebbb8"} build_url:https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/MW2cs0pYQiO1Bppv5wwGzQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c0393f614e708a996e06315c2e0201af9c18eccabf7fd2212ca634f3fd0caca2c4f39c6a1acded627c0ce53ae400b580f9f4b1096dcd651b8b5353864601f92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1f482ff503912fbd60c60dcdb15c7cab756916e3f81fbcc8d244f3b9865f5493e04da4419c3fd74c4f3756922df8bff1ede46511b73e76718796ca243e78beb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/800ae4afa20af90940332d7eb3faae6f24e42033c9eec4dd7c2f354b1d2c21f678e3c7d2a71633cf1987bb9470aa2b262f1e871f2a0fcbebc5574d7b29bebbb8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 11:23:06.215474) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 11:23:06.215871) ========= 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=ed14279e38b05397cf4aa391000001a4-1469469402.766349-1127819117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 11:23:06.301053) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 11:23:06.301397) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 11:23:06.301722) ========= ========= Total master_lag: 0.24 =========