builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1467113921.2 results: success (0) buildid: 20160628014605 builduid: afe02fc564fd4530a40f2ef0f140d030 revision: 1d4ceb3c5d5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:41.197696) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:41.198140) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:41.198410) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:41.211466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:41.211725) ========= 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=232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 04:38:41-- 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% 225M=0s 2016-06-28 04:38:41 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109142 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:41.332946) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:41.333264) ========= 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=232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018552 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:41.382670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:41.383009) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1d4ceb3c5d5a --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 1d4ceb3c5d5a --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=232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 04:38:41,492 Setting DEBUG logging. 2016-06-28 04:38:41,492 attempt 1/10 2016-06-28 04:38:41,492 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1d4ceb3c5d5a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 04:38:41,790 unpacking tar archive at: fx-team-1d4ceb3c5d5a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611488 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:42.008447) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:42.008775) ========= script_repo_revision: 1d4ceb3c5d5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:42.009233) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:42.009502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 04:38:42.020005) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2016-06-28 04:38:42.020298) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:38:42 INFO - MultiFileLogger online at 20160628 04:38:42 in /builds/slave/test 04:38:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:38:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:38:42 INFO - {'append_to_log': False, 04:38:42 INFO - 'base_work_dir': '/builds/slave/test', 04:38:42 INFO - 'blob_upload_branch': 'Fx-Team', 04:38:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:38:42 INFO - 'branch': 'Fx-Team', 04:38:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:42 INFO - 'config_files': ('talos/linux_config.py',), 04:38:42 INFO - 'default_actions': ('clobber', 04:38:42 INFO - 'read-buildbot-config', 04:38:42 INFO - 'download-and-extract', 04:38:42 INFO - 'populate-webroot', 04:38:42 INFO - 'create-virtualenv', 04:38:42 INFO - 'install', 04:38:42 INFO - 'run-tests'), 04:38:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:42 INFO - 'download_minidump_stackwalk': True, 04:38:42 INFO - 'download_symbols': 'ondemand', 04:38:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:42 INFO - 'installer_path': 'installer.exe', 04:38:42 INFO - 'log_level': 'info', 04:38:42 INFO - 'log_name': 'talos', 04:38:42 INFO - 'log_to_console': True, 04:38:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:38:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:38:42 INFO - 'opt_config_files': (), 04:38:42 INFO - 'pip_index': False, 04:38:42 INFO - 'sps_profile': False, 04:38:42 INFO - 'sps_profile_interval': 0, 04:38:42 INFO - 'suite': 'dromaeojs-e10s', 04:38:42 INFO - 'system_bits': '32', 04:38:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:42 INFO - 'title': 'talos-linux64-ix-025', 04:38:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:42 INFO - 'use_talos_json': True, 04:38:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:38:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:42 INFO - 'work_dir': 'build'} 04:38:42 INFO - ##### 04:38:42 INFO - ##### Running clobber step. 04:38:42 INFO - ##### 04:38:42 INFO - Running pre-action listener: _resource_record_pre_action 04:38:42 INFO - Running main action method: clobber 04:38:42 INFO - rmtree: /builds/slave/test/build 04:38:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:38:42 INFO - Running post-action listener: _resource_record_post_action 04:38:42 INFO - ##### 04:38:42 INFO - ##### Finished clobber step (success) 04:38:42 INFO - ##### 04:38:42 INFO - ##### 04:38:42 INFO - ##### Running read-buildbot-config step. 04:38:42 INFO - ##### 04:38:42 INFO - Running pre-action listener: _resource_record_pre_action 04:38:42 INFO - Running main action method: read_buildbot_config 04:38:42 INFO - Using buildbot properties: 04:38:42 INFO - { 04:38:42 INFO - "project": "", 04:38:42 INFO - "product": "firefox", 04:38:42 INFO - "script_repo_revision": "production", 04:38:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:38:42 INFO - "repository": "", 04:38:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:38:42 INFO - "buildid": "20160628014605", 04:38:42 INFO - "pgo_build": "True", 04:38:42 INFO - "basedir": "/builds/slave/test", 04:38:42 INFO - "buildnumber": 870, 04:38:42 INFO - "slavename": "talos-linux64-ix-025", 04:38:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:38:42 INFO - "platform": "ubuntu64_hw", 04:38:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:38:42 INFO - "branch": "fx-team", 04:38:42 INFO - "repo_path": "integration/fx-team", 04:38:42 INFO - "revision": "1d4ceb3c5d5a", 04:38:42 INFO - "stage_platform": "linux64-pgo", 04:38:42 INFO - "builduid": "afe02fc564fd4530a40f2ef0f140d030", 04:38:42 INFO - "slavebuilddir": "test" 04:38:42 INFO - } 04:38:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:38:42 INFO - Running post-action listener: _resource_record_post_action 04:38:42 INFO - ##### 04:38:42 INFO - ##### Finished read-buildbot-config step (success) 04:38:42 INFO - ##### 04:38:42 INFO - ##### 04:38:42 INFO - ##### Running download-and-extract step. 04:38:42 INFO - ##### 04:38:42 INFO - Running pre-action listener: _resource_record_pre_action 04:38:42 INFO - Running main action method: download_and_extract 04:38:42 INFO - mkdir: /builds/slave/test/build/tests 04:38:42 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')]} 04:38:42 INFO - https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:38:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:38:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:38:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/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 04:38:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/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 04:38:43 INFO - Downloaded 1361 bytes. 04:38:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:38:43 INFO - Using the following test package requirements: 04:38:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:38:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:38:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:38:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:43 INFO - u'jsshell-linux-x86_64.zip'], 04:38:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:38:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:38:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:38:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:38:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:38:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:38:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:38:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:38:43 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')]} 04:38:43 INFO - https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:38:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:38:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:38:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/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 04:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/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 04:38:44 INFO - Downloaded 24279844 bytes. 04:38:44 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'] 04:38:44 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 04:38:46 INFO - Return code: 0 04:38:46 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 04:38:46 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')]} 04:38:46 INFO - https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:38:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:38:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:38:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/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 04:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/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 04:38:47 INFO - Downloaded 24279844 bytes. 04:38:47 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'] 04:38:47 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 04:38:48 INFO - Return code: 0 04:38: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')]} 04:38:48 INFO - https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:38:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:38:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:38:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/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 04:38:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/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 04:38:50 INFO - Downloaded 14405245 bytes. 04:38:50 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'] 04:38:50 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 04:38:50 INFO - Return code: 0 04:38:50 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')]} 04:38:50 INFO - https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:38:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:38:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:38:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/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 04:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/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 04:38:54 INFO - Downloaded 60307221 bytes. 04:38:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:38:54 INFO - mkdir: /builds/slave/test/properties 04:38:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:38:54 INFO - Writing to file /builds/slave/test/properties/build_url 04:38:54 INFO - Contents: 04:38:54 INFO - build_url:https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:38:54 INFO - Running post-action listener: _resource_record_post_action 04:38:54 INFO - Running post-action listener: set_extra_try_arguments 04:38:54 INFO - ##### 04:38:54 INFO - ##### Finished download-and-extract step (success) 04:38:54 INFO - ##### 04:38:54 INFO - ##### 04:38:54 INFO - ##### Running populate-webroot step. 04:38:54 INFO - ##### 04:38:54 INFO - Running pre-action listener: _resource_record_pre_action 04:38:54 INFO - Running main action method: populate_webroot 04:38:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:38:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:38:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:38:55 INFO - '--tppagecycles', 04:38:55 INFO - '7'], 04:38:55 INFO - 'tests': ['tsvgm']}}, 04:38:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:38:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:38:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:38:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:38:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:38:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:38:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:55 INFO - 'talos_options': ['--disable-e10s'], 04:38:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:38:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:38:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:55 INFO - 'talos_options': ['--disable-e10s'], 04:38:55 INFO - 'tests': ['damp', 'tps']}, 04:38:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:55 INFO - 'tests': ['damp', 'tps']}, 04:38:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:38:55 INFO - 'tests': ['dromaeo_dom']}, 04:38:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:38:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:38:55 INFO - 'tests': ['basic_compositor_video']}, 04:38:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:38:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:38:55 INFO - 'tests': ['a11yr', 04:38:55 INFO - 'ts_paint', 04:38:55 INFO - 'tpaint', 04:38:55 INFO - 'sessionrestore', 04:38:55 INFO - 'sessionrestore_no_auto_restore', 04:38:55 INFO - 'tabpaint']}, 04:38:55 INFO - 'other-e10s': {'tests': ['a11yr', 04:38:55 INFO - 'ts_paint', 04:38:55 INFO - 'tpaint', 04:38:55 INFO - 'sessionrestore', 04:38:55 INFO - 'sessionrestore_no_auto_restore', 04:38:55 INFO - 'tabpaint']}, 04:38:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:38:55 INFO - 'ts_paint', 04:38:55 INFO - 'tpaint', 04:38:55 INFO - 'sessionrestore', 04:38:55 INFO - 'sessionrestore_no_auto_restore', 04:38:55 INFO - 'tabpaint']}, 04:38:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:38:55 INFO - 'ts_paint', 04:38:55 INFO - 'tpaint', 04:38:55 INFO - 'sessionrestore', 04:38:55 INFO - 'sessionrestore_no_auto_restore', 04:38:55 INFO - 'tabpaint']}, 04:38:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:38:55 INFO - 'tests': ['a11yr', 04:38:55 INFO - 'ts_paint', 04:38:55 INFO - 'tpaint', 04:38:55 INFO - 'sessionrestore', 04:38:55 INFO - 'sessionrestore_no_auto_restore', 04:38:55 INFO - 'tabpaint']}, 04:38:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:38:55 INFO - 'tests': ['a11yr', 04:38:55 INFO - 'ts_paint', 04:38:55 INFO - 'tpaint', 04:38:55 INFO - 'sessionrestore', 04:38:55 INFO - 'sessionrestore_no_auto_restore', 04:38:55 INFO - 'tabpaint']}, 04:38:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:38:55 INFO - 'tests': ['tsvgx', 04:38:55 INFO - 'tsvgr_opacity', 04:38:55 INFO - 'tart', 04:38:55 INFO - 'tscrollx', 04:38:55 INFO - 'cart']}, 04:38:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:38:55 INFO - 'tsvgr_opacity', 04:38:55 INFO - 'tart', 04:38:55 INFO - 'tscrollx', 04:38:55 INFO - 'cart']}, 04:38:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:55 INFO - 'talos_options': ['--disable-e10s'], 04:38:55 INFO - 'tests': ['tp5o']}, 04:38:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:55 INFO - 'tests': ['tp5o']}, 04:38:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:55 INFO - 'talos_options': ['--disable-e10s', 04:38:55 INFO - '--xperf_path', 04:38:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:38:55 INFO - 'tests': ['tp5n']}, 04:38:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:38:55 INFO - 'talos_options': ['--xperf_path', 04:38:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:38:55 INFO - 'tests': ['tp5n']}}, 04:38:55 INFO - 'talos.zip': {'path': '', 04:38:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:38:55 INFO - Running post-action listener: _resource_record_post_action 04:38:55 INFO - ##### 04:38:55 INFO - ##### Finished populate-webroot step (success) 04:38:55 INFO - ##### 04:38:55 INFO - ##### 04:38:55 INFO - ##### Running create-virtualenv step. 04:38:55 INFO - ##### 04:38:55 INFO - Running pre-action listener: _resource_record_pre_action 04:38:55 INFO - Running main action method: create_virtualenv 04:38:55 INFO - Creating virtualenv /builds/slave/test/build/venv 04:38:55 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 04:38:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:38:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:38:55 INFO - Using real prefix '/usr' 04:38:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:38:55 INFO - Installing distribute.............................................................................................................................................................................................done. 04:38:57 INFO - Installing pip.................done. 04:38:57 INFO - Return code: 0 04:38:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:38:57 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')]} 04:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:57 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')]} 04:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:57 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 0x7fad04b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7920>, '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': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', '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 04:38:57 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 04:38:57 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 04:38:57 INFO - Using env: {'DISPLAY': ':0', 04:38:57 INFO - 'HOME': '/home/cltbld', 04:38:57 INFO - 'LANG': 'en_US.UTF-8', 04:38:57 INFO - 'LANGUAGE': 'en_US:en', 04:38:57 INFO - 'LOGNAME': 'cltbld', 04:38:57 INFO - 'MAIL': '/var/mail/cltbld', 04:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:57 INFO - 'MOZ_NO_REMOTE': '1', 04:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:57 INFO - 'NO_EM_RESTART': '1', 04:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:57 INFO - 'PWD': '/builds/slave/test', 04:38:57 INFO - 'SHELL': '/bin/bash', 04:38:57 INFO - 'SHLVL': '1', 04:38:57 INFO - 'TERM': 'linux', 04:38:57 INFO - 'TMOUT': '86400', 04:38:57 INFO - 'USER': 'cltbld', 04:38:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', 04:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:57 INFO - '_': '/tools/buildbot/bin/python'} 04:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:57 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 04:38:57 INFO - Cleaning up... 04:38:57 INFO - Return code: 0 04:38:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:38:57 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')]} 04:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:57 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')]} 04:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:57 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 0x7fad04b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7920>, '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': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', '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 04:38:57 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 04:38:57 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 04:38:57 INFO - Using env: {'DISPLAY': ':0', 04:38:57 INFO - 'HOME': '/home/cltbld', 04:38:57 INFO - 'LANG': 'en_US.UTF-8', 04:38:57 INFO - 'LANGUAGE': 'en_US:en', 04:38:57 INFO - 'LOGNAME': 'cltbld', 04:38:57 INFO - 'MAIL': '/var/mail/cltbld', 04:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:57 INFO - 'MOZ_NO_REMOTE': '1', 04:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:57 INFO - 'NO_EM_RESTART': '1', 04:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:57 INFO - 'PWD': '/builds/slave/test', 04:38:57 INFO - 'SHELL': '/bin/bash', 04:38:57 INFO - 'SHLVL': '1', 04:38:57 INFO - 'TERM': 'linux', 04:38:57 INFO - 'TMOUT': '86400', 04:38:57 INFO - 'USER': 'cltbld', 04:38:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', 04:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:57 INFO - '_': '/tools/buildbot/bin/python'} 04:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:57 INFO - Downloading/unpacking psutil>=3.1.1 04:38:57 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 04:38:57 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 04:38:57 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 04:38:58 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 04:38:58 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 04:38:58 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 04:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:38:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:38:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:38:59 INFO - Installing collected packages: psutil 04:38:59 INFO - Running setup.py install for psutil 04:39:00 INFO - building 'psutil._psutil_linux' extension 04:39:00 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 04:39:00 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 04:39:00 INFO - building 'psutil._psutil_posix' extension 04:39:00 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 04:39:00 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 04:39:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:00 INFO - Successfully installed psutil 04:39:00 INFO - Cleaning up... 04:39:00 INFO - Return code: 0 04:39:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:00 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 0x7fad04b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7920>, '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': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', '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 04:39:00 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 04:39:00 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 04:39:00 INFO - Using env: {'DISPLAY': ':0', 04:39:00 INFO - 'HOME': '/home/cltbld', 04:39:00 INFO - 'LANG': 'en_US.UTF-8', 04:39:00 INFO - 'LANGUAGE': 'en_US:en', 04:39:00 INFO - 'LOGNAME': 'cltbld', 04:39:00 INFO - 'MAIL': '/var/mail/cltbld', 04:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:00 INFO - 'MOZ_NO_REMOTE': '1', 04:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:00 INFO - 'NO_EM_RESTART': '1', 04:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:00 INFO - 'PWD': '/builds/slave/test', 04:39:00 INFO - 'SHELL': '/bin/bash', 04:39:00 INFO - 'SHLVL': '1', 04:39:00 INFO - 'TERM': 'linux', 04:39:00 INFO - 'TMOUT': '86400', 04:39:00 INFO - 'USER': 'cltbld', 04:39:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', 04:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:00 INFO - '_': '/tools/buildbot/bin/python'} 04:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:39:00 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 04:39:00 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 04:39:00 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 04:39:00 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 04:39:00 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 04:39:00 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 04:39:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:39:02 INFO - Installing collected packages: mozsystemmonitor 04:39:02 INFO - Running setup.py install for mozsystemmonitor 04:39:02 INFO - Successfully installed mozsystemmonitor 04:39:02 INFO - Cleaning up... 04:39:02 INFO - Return code: 0 04:39:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:02 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 0x7fad04b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7920>, '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': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', '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 04:39:02 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 04:39:02 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 04:39:02 INFO - Using env: {'DISPLAY': ':0', 04:39:02 INFO - 'HOME': '/home/cltbld', 04:39:02 INFO - 'LANG': 'en_US.UTF-8', 04:39:02 INFO - 'LANGUAGE': 'en_US:en', 04:39:02 INFO - 'LOGNAME': 'cltbld', 04:39:02 INFO - 'MAIL': '/var/mail/cltbld', 04:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:02 INFO - 'MOZ_NO_REMOTE': '1', 04:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:02 INFO - 'NO_EM_RESTART': '1', 04:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:02 INFO - 'PWD': '/builds/slave/test', 04:39:02 INFO - 'SHELL': '/bin/bash', 04:39:02 INFO - 'SHLVL': '1', 04:39:02 INFO - 'TERM': 'linux', 04:39:02 INFO - 'TMOUT': '86400', 04:39:02 INFO - 'USER': 'cltbld', 04:39:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', 04:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:02 INFO - '_': '/tools/buildbot/bin/python'} 04:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:03 INFO - Downloading/unpacking jsonschema==2.5.1 04:39:03 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 04:39:03 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 04:39:03 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 04:39:03 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 04:39:03 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 04:39:03 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 04:39:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:39:04 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 04:39:04 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 04:39:04 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 04:39:04 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 04:39:04 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 04:39:04 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 04:39:05 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:05 INFO - warning: no files found matching '*.txt' 04:39:05 INFO - no previously-included directories found matching 'build' 04:39:05 INFO - no previously-included directories found matching 'dist' 04:39:05 INFO - no previously-included directories found matching '.git*' 04:39:05 INFO - Installing collected packages: jsonschema, functools32 04:39:05 INFO - Running setup.py install for functools32 04:39:05 INFO - warning: no files found matching '*.txt' 04:39:05 INFO - no previously-included directories found matching 'build' 04:39:05 INFO - no previously-included directories found matching 'dist' 04:39:05 INFO - no previously-included directories found matching '.git*' 04:39:05 INFO - Successfully installed jsonschema functools32 04:39:05 INFO - Cleaning up... 04:39:05 INFO - Return code: 0 04:39:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:05 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 0x7fad04b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7920>, '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': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', '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 04:39:05 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 04:39:05 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 04:39:05 INFO - Using env: {'DISPLAY': ':0', 04:39:05 INFO - 'HOME': '/home/cltbld', 04:39:05 INFO - 'LANG': 'en_US.UTF-8', 04:39:05 INFO - 'LANGUAGE': 'en_US:en', 04:39:05 INFO - 'LOGNAME': 'cltbld', 04:39:05 INFO - 'MAIL': '/var/mail/cltbld', 04:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:05 INFO - 'MOZ_NO_REMOTE': '1', 04:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:05 INFO - 'NO_EM_RESTART': '1', 04:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:05 INFO - 'PWD': '/builds/slave/test', 04:39:05 INFO - 'SHELL': '/bin/bash', 04:39:05 INFO - 'SHLVL': '1', 04:39:05 INFO - 'TERM': 'linux', 04:39:05 INFO - 'TMOUT': '86400', 04:39:05 INFO - 'USER': 'cltbld', 04:39:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', 04:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:05 INFO - '_': '/tools/buildbot/bin/python'} 04:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:05 INFO - Downloading/unpacking blobuploader==1.2.4 04:39:05 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 04:39:05 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 04:39:05 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 04:39:05 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 04:39:05 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 04:39:05 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 04:39:07 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:07 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 04:39:07 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 04:39:07 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 04:39:07 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 04:39:07 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 04:39:07 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 04:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:08 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 04:39:08 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 04:39:08 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 04:39:08 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 04:39:08 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 04:39:08 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 04:39:08 INFO - Downloading docopt-0.6.1.tar.gz 04:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:08 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:08 INFO - Running setup.py install for blobuploader 04:39:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:08 INFO - Running setup.py install for requests 04:39:08 INFO - Running setup.py install for docopt 04:39:08 INFO - Successfully installed blobuploader requests docopt 04:39:08 INFO - Cleaning up... 04:39:09 INFO - Return code: 0 04:39:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:09 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 0x7fad04b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7920>, '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': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', '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 04:39:09 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 04:39:09 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 04:39:09 INFO - Using env: {'DISPLAY': ':0', 04:39:09 INFO - 'HOME': '/home/cltbld', 04:39:09 INFO - 'LANG': 'en_US.UTF-8', 04:39:09 INFO - 'LANGUAGE': 'en_US:en', 04:39:09 INFO - 'LOGNAME': 'cltbld', 04:39:09 INFO - 'MAIL': '/var/mail/cltbld', 04:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:09 INFO - 'MOZ_NO_REMOTE': '1', 04:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:09 INFO - 'NO_EM_RESTART': '1', 04:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:09 INFO - 'PWD': '/builds/slave/test', 04:39:09 INFO - 'SHELL': '/bin/bash', 04:39:09 INFO - 'SHLVL': '1', 04:39:09 INFO - 'TERM': 'linux', 04:39:09 INFO - 'TMOUT': '86400', 04:39:09 INFO - 'USER': 'cltbld', 04:39:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', 04:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:09 INFO - '_': '/tools/buildbot/bin/python'} 04:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:09 INFO - Running setup.py (path:/tmp/pip-JA3StM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:09 INFO - Running setup.py (path:/tmp/pip-fUChcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:09 INFO - Running setup.py (path:/tmp/pip-o2_8p2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:09 INFO - Running setup.py (path:/tmp/pip-VdvLzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:09 INFO - Running setup.py (path:/tmp/pip-L8kqwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:09 INFO - Running setup.py (path:/tmp/pip-RLqkQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:09 INFO - Running setup.py (path:/tmp/pip-1rpPpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:09 INFO - Running setup.py (path:/tmp/pip-GT6DuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:09 INFO - Running setup.py (path:/tmp/pip-R6t6zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:09 INFO - Running setup.py (path:/tmp/pip-HJqTb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:09 INFO - Running setup.py (path:/tmp/pip-Ic1tBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:10 INFO - Running setup.py (path:/tmp/pip-A10KZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:10 INFO - Running setup.py (path:/tmp/pip-hd4PmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:10 INFO - Running setup.py (path:/tmp/pip-IT8LXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:10 INFO - Running setup.py (path:/tmp/pip-9lOuZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:10 INFO - Running setup.py (path:/tmp/pip-6WNmeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:10 INFO - Running setup.py (path:/tmp/pip-0ag5vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:10 INFO - Running setup.py install for manifestparser 04:39:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:10 INFO - Running setup.py install for mozcrash 04:39:10 INFO - Running setup.py install for mozdebug 04:39:10 INFO - Running setup.py install for mozdevice 04:39:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:39:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:10 INFO - Running setup.py install for mozfile 04:39:11 INFO - Running setup.py install for mozhttpd 04:39:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:11 INFO - Running setup.py install for mozinfo 04:39:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:11 INFO - Running setup.py install for mozInstall 04:39:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:11 INFO - Running setup.py install for mozleak 04:39:11 INFO - Running setup.py install for mozlog 04:39:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:11 INFO - Running setup.py install for moznetwork 04:39:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:11 INFO - Running setup.py install for mozprocess 04:39:11 INFO - Running setup.py install for mozprofile 04:39:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:11 INFO - Running setup.py install for mozrunner 04:39:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:11 INFO - Running setup.py install for mozscreenshot 04:39:12 INFO - Running setup.py install for moztest 04:39:12 INFO - Running setup.py install for mozversion 04:39:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:12 INFO - Cleaning up... 04:39:12 INFO - Return code: 0 04:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:12 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 0x7fad04b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7920>, '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': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', '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 04:39:12 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 04:39:12 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 04:39:12 INFO - Using env: {'DISPLAY': ':0', 04:39:12 INFO - 'HOME': '/home/cltbld', 04:39:12 INFO - 'LANG': 'en_US.UTF-8', 04:39:12 INFO - 'LANGUAGE': 'en_US:en', 04:39:12 INFO - 'LOGNAME': 'cltbld', 04:39:12 INFO - 'MAIL': '/var/mail/cltbld', 04:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:12 INFO - 'MOZ_NO_REMOTE': '1', 04:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:12 INFO - 'NO_EM_RESTART': '1', 04:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:12 INFO - 'PWD': '/builds/slave/test', 04:39:12 INFO - 'SHELL': '/bin/bash', 04:39:12 INFO - 'SHLVL': '1', 04:39:12 INFO - 'TERM': 'linux', 04:39:12 INFO - 'TMOUT': '86400', 04:39:12 INFO - 'USER': 'cltbld', 04:39:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', 04:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:12 INFO - '_': '/tools/buildbot/bin/python'} 04:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:12 INFO - Running setup.py (path:/tmp/pip-rchXIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:12 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)) 04:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:12 INFO - Running setup.py (path:/tmp/pip-Lnb6YZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:12 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)) 04:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:12 INFO - Running setup.py (path:/tmp/pip-Sd3npJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:12 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)) 04:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:12 INFO - Running setup.py (path:/tmp/pip-rUmyy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:12 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)) 04:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:12 INFO - Running setup.py (path:/tmp/pip-f6Cmyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:12 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)) 04:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:12 INFO - Running setup.py (path:/tmp/pip-6bv5VX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:12 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)) 04:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:12 INFO - Running setup.py (path:/tmp/pip-xDIuM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:13 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)) 04:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:13 INFO - Running setup.py (path:/tmp/pip-_UKpi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:13 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)) 04:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:13 INFO - Running setup.py (path:/tmp/pip-dHRUhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:13 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)) 04:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:13 INFO - Running setup.py (path:/tmp/pip-79kkmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:13 INFO - Running setup.py (path:/tmp/pip-YuG17X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:13 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)) 04:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:13 INFO - Running setup.py (path:/tmp/pip-6UNDkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:13 INFO - Running setup.py (path:/tmp/pip-nbE1Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:13 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)) 04:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:13 INFO - Running setup.py (path:/tmp/pip-Bxv13O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:13 INFO - Running setup.py (path:/tmp/pip-yGPGzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:13 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)) 04:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:13 INFO - Running setup.py (path:/tmp/pip-JEFH9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:13 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)) 04:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:13 INFO - Running setup.py (path:/tmp/pip-Q4mEzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:13 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)) 04:39:13 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)) 04:39:13 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)) 04:39:13 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)) 04:39:13 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)) 04:39:13 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)) 04:39:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:13 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 04:39:13 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 04:39:13 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 04:39:13 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 04:39:13 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 04:39:13 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 04:39:15 INFO - Downloading blessings-1.6.tar.gz 04:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:15 INFO - Installing collected packages: blessings 04:39:15 INFO - Running setup.py install for blessings 04:39:15 INFO - Successfully installed blessings 04:39:15 INFO - Cleaning up... 04:39:15 INFO - Return code: 0 04:39:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:16 INFO - Reading from file tmpfile_stdout 04:39:16 INFO - Current package versions: 04:39:16 INFO - argparse == 1.2.1 04:39:16 INFO - blessings == 1.6 04:39:16 INFO - blobuploader == 1.2.4 04:39:16 INFO - docopt == 0.6.1 04:39:16 INFO - functools32 == 3.2.3-2 04:39:16 INFO - jsonschema == 2.5.1 04:39:16 INFO - manifestparser == 1.1 04:39:16 INFO - mozInstall == 1.12 04:39:16 INFO - mozcrash == 0.17 04:39:16 INFO - mozdebug == 0.1 04:39:16 INFO - mozdevice == 0.48 04:39:16 INFO - mozfile == 1.2 04:39:16 INFO - mozhttpd == 0.7 04:39:16 INFO - mozinfo == 0.9 04:39:16 INFO - mozleak == 0.1 04:39:16 INFO - mozlog == 3.2 04:39:16 INFO - moznetwork == 0.27 04:39:16 INFO - mozprocess == 0.22 04:39:16 INFO - mozprofile == 0.28 04:39:16 INFO - mozrunner == 6.11 04:39:16 INFO - mozscreenshot == 0.1 04:39:16 INFO - mozsystemmonitor == 0.3 04:39:16 INFO - moztest == 0.7 04:39:16 INFO - mozversion == 1.4 04:39:16 INFO - psutil == 3.1.1 04:39:16 INFO - requests == 1.2.3 04:39:16 INFO - wsgiref == 0.1.2 04:39:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:16 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 0x7fad04b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7920>, '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': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', '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 04:39:16 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 04:39:16 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 04:39:16 INFO - Using env: {'DISPLAY': ':0', 04:39:16 INFO - 'HOME': '/home/cltbld', 04:39:16 INFO - 'LANG': 'en_US.UTF-8', 04:39:16 INFO - 'LANGUAGE': 'en_US:en', 04:39:16 INFO - 'LOGNAME': 'cltbld', 04:39:16 INFO - 'MAIL': '/var/mail/cltbld', 04:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:16 INFO - 'MOZ_NO_REMOTE': '1', 04:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:16 INFO - 'NO_EM_RESTART': '1', 04:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:16 INFO - 'PWD': '/builds/slave/test', 04:39:16 INFO - 'SHELL': '/bin/bash', 04:39:16 INFO - 'SHLVL': '1', 04:39:16 INFO - 'TERM': 'linux', 04:39:16 INFO - 'TMOUT': '86400', 04:39:16 INFO - 'USER': 'cltbld', 04:39:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', 04:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:16 INFO - '_': '/tools/buildbot/bin/python'} 04:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:16 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)) 04:39:16 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)) 04:39:16 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)) 04:39:16 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)) 04:39:16 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)) 04:39:16 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)) 04:39:16 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)) 04:39:16 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)) 04:39:16 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)) 04:39:16 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)) 04:39:16 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)) 04:39:16 INFO - Cleaning up... 04:39:16 INFO - Return code: 0 04:39:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:16 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 0x7fad04b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7920>, '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': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', '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 04:39:16 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 04:39:16 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 04:39:16 INFO - Using env: {'DISPLAY': ':0', 04:39:16 INFO - 'HOME': '/home/cltbld', 04:39:16 INFO - 'LANG': 'en_US.UTF-8', 04:39:16 INFO - 'LANGUAGE': 'en_US:en', 04:39:16 INFO - 'LOGNAME': 'cltbld', 04:39:16 INFO - 'MAIL': '/var/mail/cltbld', 04:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:16 INFO - 'MOZ_NO_REMOTE': '1', 04:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:16 INFO - 'NO_EM_RESTART': '1', 04:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:16 INFO - 'PWD': '/builds/slave/test', 04:39:16 INFO - 'SHELL': '/bin/bash', 04:39:16 INFO - 'SHLVL': '1', 04:39:16 INFO - 'TERM': 'linux', 04:39:16 INFO - 'TMOUT': '86400', 04:39:16 INFO - 'USER': 'cltbld', 04:39:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', 04:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:16 INFO - '_': '/tools/buildbot/bin/python'} 04:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:39:16 INFO - Cleaning up... 04:39:16 INFO - Return code: 0 04:39:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad04b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7920>, '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': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', '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 04:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:39:16 INFO - Using env: {'DISPLAY': ':0', 04:39:16 INFO - 'HOME': '/home/cltbld', 04:39:16 INFO - 'LANG': 'en_US.UTF-8', 04:39:16 INFO - 'LANGUAGE': 'en_US:en', 04:39:16 INFO - 'LOGNAME': 'cltbld', 04:39:16 INFO - 'MAIL': '/var/mail/cltbld', 04:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:16 INFO - 'MOZ_NO_REMOTE': '1', 04:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:16 INFO - 'NO_EM_RESTART': '1', 04:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:16 INFO - 'PWD': '/builds/slave/test', 04:39:16 INFO - 'SHELL': '/bin/bash', 04:39:16 INFO - 'SHLVL': '1', 04:39:16 INFO - 'TERM': 'linux', 04:39:16 INFO - 'TMOUT': '86400', 04:39:16 INFO - 'USER': 'cltbld', 04:39:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', 04:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:16 INFO - '_': '/tools/buildbot/bin/python'} 04:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:16 INFO - Downloading/unpacking flake8 04:39:16 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 04:39:16 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 04:39:16 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 04:39:16 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 04:39:16 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 04:39:16 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 04:39:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:39:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:39:18 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 04:39:18 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 04:39:18 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 04:39:18 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 04:39:18 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 04:39:18 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 04:39:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:39:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:39:18 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 04:39:18 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 04:39:18 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 04:39:18 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 04:39:18 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 04:39:18 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 04:39:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:39:19 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 04:39:19 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 04:39:19 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 04:39:19 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 04:39:19 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 04:39:19 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 04:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:39:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:19 INFO - no previously-included directories found matching 'docs/_build' 04:39:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:39:19 INFO - Running setup.py install for pep8 04:39:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:19 INFO - no previously-included directories found matching 'docs/_build' 04:39:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:39:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:39:19 INFO - Cleaning up... 04:39:20 INFO - Return code: 0 04:39:20 INFO - Running post-action listener: _resource_record_post_action 04:39:20 INFO - Running post-action listener: _start_resource_monitoring 04:39:20 INFO - Starting resource monitoring. 04:39:20 INFO - ##### 04:39:20 INFO - ##### Finished create-virtualenv step (success) 04:39:20 INFO - ##### 04:39:20 INFO - ##### 04:39:20 INFO - ##### Running install step. 04:39:20 INFO - ##### 04:39:20 INFO - Running pre-action listener: _resource_record_pre_action 04:39:20 INFO - Running main action method: install 04:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:20 INFO - Reading from file tmpfile_stdout 04:39:20 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:20 INFO - Reading from file tmpfile_stdout 04:39:20 INFO - Output received: 04:39:20 INFO - Usage: mozinstall [options] installer 04:39:20 INFO - Options: 04:39:20 INFO - -h, --help show this help message and exit 04:39:20 INFO - -d DEST, --destination=DEST 04:39:20 INFO - Directory to install application into. [default: 04:39:20 INFO - "/builds/slave/test"] 04:39:20 INFO - --app=APP Application being installed. [default: firefox] 04:39:20 INFO - mkdir: /builds/slave/test/build/application 04:39:20 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'] 04:39:20 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 04:39:38 INFO - Reading from file tmpfile_stdout 04:39:38 INFO - Output received: 04:39:38 INFO - /builds/slave/test/build/application/firefox/firefox 04:39:38 INFO - Running post-action listener: _resource_record_post_action 04:39:38 INFO - ##### 04:39:38 INFO - ##### Finished install step (success) 04:39:38 INFO - ##### 04:39:38 INFO - ##### 04:39:38 INFO - ##### Running run-tests step. 04:39:38 INFO - ##### 04:39:38 INFO - Running pre-action listener: _resource_record_pre_action 04:39:38 INFO - Running main action method: run_tests 04:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:39:38 INFO - Python 2.7.3 04:39:38 INFO - Return code: 0 04:39:38 INFO - grabbing minidump binary from tooltool 04:39:38 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')]} 04:39:38 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 0xdf6570>, '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 0xdf7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf7920>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:39:38 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 04:39:38 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 04:39:38 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 04:39:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:39:38 INFO - Return code: 0 04:39:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:39:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:39:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:39:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:39:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:39:39 INFO - Return code: 0 04:39:39 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:39:39 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:39:39 INFO - Using env: {'DISPLAY': ':0', 04:39:39 INFO - 'HOME': '/home/cltbld', 04:39:39 INFO - 'LANG': 'en_US.UTF-8', 04:39:39 INFO - 'LANGUAGE': 'en_US:en', 04:39:39 INFO - 'LOGNAME': 'cltbld', 04:39:39 INFO - 'MAIL': '/var/mail/cltbld', 04:39:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:39:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:39 INFO - 'MOZ_NO_REMOTE': '1', 04:39:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:39 INFO - 'NO_EM_RESTART': '1', 04:39:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:39 INFO - 'PWD': '/builds/slave/test', 04:39:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:39:39 INFO - 'SHELL': '/bin/bash', 04:39:39 INFO - 'SHLVL': '1', 04:39:39 INFO - 'TERM': 'linux', 04:39:39 INFO - 'TMOUT': '86400', 04:39:39 INFO - 'USER': 'cltbld', 04:39:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480', 04:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:39 INFO - '_': '/tools/buildbot/bin/python'} 04:39:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:39:39 INFO - mozversion application_buildid: 20160628014605 04:39:39 INFO - mozversion application_changeset: 1d4ceb3c5d5aed6afc6ec71239b2d741df893379 04:39:39 INFO - mozversion application_display_name: Nightly 04:39:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:39:39 INFO - mozversion application_name: Firefox 04:39:39 INFO - mozversion application_remotingname: firefox 04:39:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:39:39 INFO - mozversion application_vendor: Mozilla 04:39:39 INFO - mozversion application_version: 50.0a1 04:39:39 INFO - mozversion platform_buildid: 20160628014605 04:39:39 INFO - mozversion platform_changeset: 1d4ceb3c5d5aed6afc6ec71239b2d741df893379 04:39:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:39:39 INFO - mozversion platform_version: 50.0a1 04:39:39 INFO - using testdate: 1467113979 04:39:39 INFO - actual date: 1467113979 04:39:39 INFO - starting webserver on 'localhost:56403' 04:39:39 INFO - SUITE-START | Running 2 tests 04:39:39 INFO - TEST-START | dromaeo_css 04:39:39 INFO - operating with platform_type : linux_ 04:39:39 INFO - Initialising browser for dromaeo_css test... 04:39:39 INFO - TEST-INFO | started process 14307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7FERTJ/profile http://localhost:56403/getInfo.html) 04:39:44 INFO - PROCESS | 14307 | __metrics Screen width/height:1600/1200 04:39:44 INFO - PROCESS | 14307 | colorDepth:24 04:39:44 INFO - PROCESS | 14307 | Browser inner width/height: 1024/697 04:39:44 INFO - PROCESS | 14307 | __metrics 04:39:45 ERROR - PROCESS | 14307 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:39:45 INFO - TEST-INFO | 14307: exit 0 04:39:45 INFO - Browser initialized. 04:39:45 INFO - Running cycle 1/1 for dromaeo_css test... 04:39:45 INFO - TEST-INFO | started process 14427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7FERTJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:57 INFO - PROCESS | 14427 | RSS: Main: 185327616 04:39:57 INFO - PROCESS | 14427 | 04:40:47 INFO - PROCESS | 14427 | 1467114047422 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] 04:42:55 INFO - PROCESS | 14427 | Cycle 1(1): loaded http://localhost:56403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56403/tests/dromaeo/cssquery-ext.html) 04:42:56 INFO - PROCESS | 14427 | RSS: Main: 188600320 04:42:56 INFO - PROCESS | 14427 | 04:45:58 INFO - PROCESS | 14427 | Cycle 1(1): loaded http://localhost:56403/tests/dromaeo/cssquery-ext.html (next: http://localhost:56403/tests/dromaeo/cssquery-jquery.html) 04:45:59 INFO - PROCESS | 14427 | RSS: Main: 187629568 04:45:59 INFO - PROCESS | 14427 | 04:49:01 INFO - PROCESS | 14427 | Cycle 1(1): loaded http://localhost:56403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56403/tests/dromaeo/cssquery-mootools.html) 04:49:01 INFO - PROCESS | 14427 | RSS: Main: 189743104 04:49:01 INFO - PROCESS | 14427 | 04:52:03 INFO - PROCESS | 14427 | Cycle 1(1): loaded http://localhost:56403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56403/tests/dromaeo/cssquery-prototype.html) 04:52:04 INFO - PROCESS | 14427 | RSS: Main: 186396672 04:52:04 INFO - PROCESS | 14427 | 04:55:06 INFO - PROCESS | 14427 | Cycle 1(1): loaded http://localhost:56403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56403/tests/dromaeo/cssquery-yui.html) 04:55:07 INFO - PROCESS | 14427 | RSS: Main: 189198336 04:55:07 INFO - PROCESS | 14427 | 04:58:09 INFO - PROCESS | 14427 | Cycle 1(1): loaded http://localhost:56403/tests/dromaeo/cssquery-yui.html (next: http://localhost:56403/tests/dromaeo/cssquery-dojo.html) 04:58:09 INFO - PROCESS | 14427 | RSS: Main: 190017536 04:58:09 INFO - PROCESS | 14427 | 04:58:09 INFO - PROCESS | 14427 | __start_tp_report 04:58:09 INFO - PROCESS | 14427 | _x_x_mozilla_page_load 04:58:09 INFO - PROCESS | 14427 | _x_x_mozilla_page_load_details 04:58:09 INFO - PROCESS | 14427 | |i|pagename|runs| 04:58:09 INFO - PROCESS | 14427 | |0;dojo.html;3073.8770449182034;3127.968720312796;3161.541576471411;3181.3319202967377;3181.6818318168184;5304.973475132619;5313.043652142617;5364.088105022146;5416.458354164582;5420.051490989071;5222.294990176325;5351.170568561869;5360.65155764875;5366.06093933562;5435.266239057726;4760.3573517575205;4795.808167673289;4875.731834749087;4944.505549445044;4964.528369804881;801.3282649539043;4841.2012018016985;4891.241857512074;4920.261960705905;4962.528559786814;4884.535969082932;4902.092977961548;4902.975485122587;4915.16442204826;4959.256111583255;4775.498572649856;4910.631702622282;4913.484084171182;4946.653734238605;4963.503649635044;4708.058388322315;4720;4729.834455794065;4762.809487620491;4768.833090841838;5196.142636464979;5240.973795131038;5268.420473747885;5279.287296215;5280.419153893069;5645.096784514499;5647.152927060933;5659.547236221092;5673.63121397112;5682.7442765075675;5742.138679198112;5746;5746.9425305747245;5749.0514065179195;5790.565707571906;5351.063563876306;5418.376886658006;5425.186222066722;5430.348358197002;5432.728363581805;5763.682997435181;5797.275340582427;5810;5817;5877.853053673693;5572.86067848307;5623.606347555632;5632.746526406321;5649.576281778883;5654.434556544395;5579.0515612346;5651.858703532444;5656.095024796013;5665.858353541194;5683.119116536861;5625.8593535161945;5637.718114094361;5711.057675483582;5733;5758.596898217084;5571.860703482445;5671.234383358194;5679.148127780783;5696.088625819849;5771.740271687784;4324.437823082979;4378.08060307339;4391.736495810262;4397.516273209944;4435.268180750205;3884.2814079395403;3894.9610503894596;3926.6466018058513;3932.3315036443873;3974.066094467798;5472.151816468454;5472.288602481652;5479.5342395896;5506.64206826555;5508.614396992252;5603.131514615241;5740.326191237611;5768.048272035151;5775.682337471395;5787.565932555075;5499.175123731472;5520;5557.472040156179;5560.944390556043;5573.665580065209;4759;4780.856574302777;4784.425868895755;4810.879728006757;4827.42070951488;5821.883562328814;5961.731722072517;6030.728617212236;6043;6049.5462840287155;5826.096954972071;5826.329972053268;5834.066549352253;5839.065749480063;5844.561657875592;6004.969975150097;6005.219321488178;6008.939910600838;6050.84872878164;6066.787662431793;5531.197976293495;5557.499825015606;5574.721263936706;5612;5684.687342196219;5681.573881958787;5696.344920334049;5699.5725320600295;5706.771729130955;5708;5575.526080283222;5588.580856435865;5590.413006634245;5592.105263157875;5608.6073974821375;5415.288350404609;5498.477644623755;5520.779168833202;5540.612157148961;5571;5309.177077552986;5369.1140961740875;5369.865753356197;5371.785128594969;5428;5531.446855314597;5578.63738856973;5608.327000759772;5615.438456154352;5668.773249069991;5526.06056970308;5529.944700552943;5530.55755539564;5534.750936207961;5539.806106786243 04:58:09 INFO - PROCESS | 14427 | |1;ext.html;567.0700051914861;609.8871708733884;617.0682269772648;631.5452873930772;635.4725577770452;41856.16287674245;43175.56824431759;43322.13355732884;43328.35007474883;46606.7669661652;44699;45061;45571.77214113925;45643.31535026969;45756.771216143956;8629.741107766762;8803.603837827313;8851.911480885205;8868.600912958933;8877.668349747557;8652;8784.692535761249;8815.294776417872;8820.029796722356;8832.249258813008;8841.248493878029;8872;8874.733757987271;8916.331275154356;8917.866232006525;8754.956225218864;8801.823963520726;8813.030566637664;8830.735077947671;8833.249173820233;8750.86873696895;8760.649574017032;8786.86819697705;8800.603972821174;8816.779580510474;42031.1593768126;42144.78927605373;42473.57526424727;42795.78602107001;42962.78518607418;3393.5079413484905;3445.104272889042;3522.154682876117;3583.7849729016084;3586.22896077342;29875.850620746973;31868;32597.185070373194;32616.836915815507;32757.508637370458;4179.540250572434;4283.250431174563;4373.103513779699;4469.307257375112;4516.458025036984;349635;349700.2514987434;350062;352058;352608;60210;60758;61107;61149;61451.6927415369;35596.110097247256;63555.36444635587;63583.046254306224;63942;63964;14557.490487832874;16246.431374902058;16280.348786048662;16326.673466530603;16348.591285217964;12597.559085431965;12673.112882098165;12713.936430317974;12728.490860365482;12814.615561533168;19005.619887602446;19283.710744338845;19391.4182574523;19394;19479;7280.563166210044;7324.4140468763435;7428.405727541784;7503.137139229058;7534.171241163468;1005.6178652112151;1022.437659287389;1027.091024443373;1100.8403781451646;1162.7384288047394;33034.8348258262;33064;33083;33247.3350532988;33593.83203083969;1100.6808025672626;1123.1913022623698;1196.0398014913194;1219.1039585904352;1246.7506498700116;17020.404285849934;17066.573335666708;17244.741328880078;17303.91348043277;17339.653206936044;522073;525415;527642;528680;529176;57977.42022579804;58649;58922.41077589255;59116.40883591195;59324.40675593275;1342.4563051963971;1343.5431953135785;1361.0540674231513;1372.9656758580916;1377.7175678985784;30895.84552077225;32461.67538324681;32546.511802323457;32994.84827729989;33033.83483082569;45812.31281530846;46111;46165.53834461747;46172;46241;440101;444405;444751;445321;446754;25881.870590646926;25891.61162582525;26164.82258298419;26236.60645090287;26244.868775656;47506.76246618745;48499.27251091166;48524.27213591729;48682.75658621826;49393.25910111423;40413.191736164525;41272.79363603163;42005.78997104995;42012.789936050125;42492.36261456019;40383.79808100941;40916.590834092465;41112.58887411207;41562.37656435216;41795.7910210447;41550.792246038574;43997.56002439935;44250.33624495571;44491.33263000993;45184.32223516584;35708.821455892554;36181.638183617826;37396;39341;40508.79745601253;28684;29029;29144.854275728485;29162.338275568512;29441.705582943898 04:58:09 INFO - PROCESS | 14427 | |2;jquery.html;394.24502078519635;394.8657456464803;399.5265610251852;402.71004876488917;414.5046669230269;18149.183286752093;19429.417117486497;19689;19760.604787904253;20547.794522054774;18141.365052223176;18954.43136705901;19018.2392704292;19466.416007519798;19642.214311427524;5292.788288468457;5393.217983392406;5684.289463817023;5821.068629019358;5832.270966129234;5777.104548794922;5820.35976042635;5830.475257226849;5833.912491312633;5853.678047707374;5250.081235783741;5342.866428339284;5348.732563371836;5354.41101478837;5698.746275819313;5288.0745869472885;5308.787648494055;5363.19552067193;5364.490373414539;5371.785128594852;6712.39588437043;7302.488825782198;7322.81692957675;7468.5145465544565;7479.663415146331;23956.803628335332;26008.609870851953;26331.34171645705;26874.5968810468;27102.322441939108;2422.6729391532094;2432.768886955754;2535.7971362291155;2539.4032402385424;2576.4589436218416;15454.1500217488;16375.754363684555;16460;16538.83461165385;16863;2053.414776788608;2164.7726988666122;2181.7054697615777;2213.557288542282;2243.1027588964544;92564.07435925622;93564;94215;94887.52556237244;96594.51702741512;16709.665806684043;17803.910980445016;18442;18891;18921.526961825788;32345.191370215933;32474.837625812193;32679.67320326814;32687;32803.34393312121;9727.464989425649;9911.752206194902;10022.298439109192;10025.649102281532;10283.537240824031;8208.58957052157;8217.917820821835;8284.053247486836;8306.501609903304;8625.69810056645;8765.824683506295;8931.687390941415;8996.145366190201;9259.027802080684;9339.272234636614;3425.7088147507743;3425.9828700856833;3489.45913383426;3547.2728090741853;3681.9263614727556;906.3610154840821;978.8091322192247;1004.8141093897506;1034.9534270957824;1061.156380677348;18441.1701473434;19314.420567383;19755.901220493804;20140.597188056156;20493.79506204919;980.9166220871306;1002.6490728245202;1006.3760468509424;1049.5644307612408;1054.5676272728144;10727.892721072845;11158.776824463464;11167.83248251277;11210.439478026066;11224.326540407601;471969;474510;476081;478541;480384;81831;83206;84659.15340846636;94105;97504.51247743858;987.76293689514;1035.13566172247;1036.6734478639205;1038.3665963762098;1056.2975621211808;18405.63188736191;18596;18658.16038278308;18742.68801183904;18831.24675012984;38045;41906.161876762904;42103;42464.36303455389;42511.1497770049;47372.52627473819;57911.420885792286;57927;58381.70809145927;58795;5543.1962365455975;5842.159719688285;8990.68532601382;8999.460032398078;9253.67612133572;10356.482175891326;13411.128276661986;14064.507742228972;14097.788533171806;14419.134851908919;12230.633081007583;12260.509579617072;12336.568220112253;12497.25016499013;12514.812277816021;12157.331346776013;12347;12468.563600273947;12541.874581254435;12579.622611321674;12453.315067671365;12474.688132796753;12630;12675.239485630891;12733.363331833187;8691.217790398894;9060.637574496946;9115.96731974302;9123.680671176477;9255.35212535116;9310.394824336396;11950.34273114987;12241.938790305992;12285.201461904948;12305.815412768994 04:58:09 INFO - PROCESS | 14427 | |3;mootools.html;1460.364741337518;1467;1588.2693960778042;1725.3357457378906;1728.9453433405613;7731.420143489247;8353.540555269457;8394.454360466572;8868.866966995492;8894.332925030632;8667.69663061793;8700.912990870089;8764.079771623983;8772.254358379529;8804.64781408743;2254.458929856835;2293.392251053472;2295.3228797504776;2300.919467818627;2304.665823455598;2274.601944659678;2285.1773361589812;2322.210448447536;2325.965110523335;2328.3131476214558;2263.4454558633156;2271.068861766676;2280.2589158523465;2322.5587138443725;2322.756110608387;2227.654713519407;2236.317923033474;2258;2263.6038693228784;2269.1830940861196;2192.9451763705874;2243.5849367866836;2244.236959433784;2254.943626409353;2269.727632684072;8808.383413161082;8905.688300909502;8908.955455222747;8934.10658934108;8938.910610893872;5038.294638750578;5188.325517682715;5197.662151960149;5213.582913366921;5230.476952304739;3124.500239884845;3133.9059828204963;3214.324991751735;3215.1962009497624;3229.9677003229904;1091.6015654286127;1102.1513434655271;1123.7527743896412;1124.3759713359082;1126.881677423867;11613.535458581646;11620.418979051014;11620.767584648343;11639.6508104757;11715.472803723767;4553.908921821545;4555.908881822411;4629;4660.13787449323;4686.226772582554;9993.900060999442;9997.80004399908;10006.949965250273;10030.699079027641;10038.548265328078;5080.491950804964;5081.060003899291;5142.51146141116;5160.716160611128;5181.53366197044;4316.438862947797;4623.052274283831;4681.063787242497;4752.334673145762;4785.353977213102;3900.4539364488996;3919.7256192066284;3999.0802115513593;4024.7182697210915;4144.79276036203;1202.3146806320487;1217.7260116473722;1222.7615614954998;1235.123062625546;1237.9195352302072;786.697121608185;903.1440389998485;921.7188757428914;928.4475736936512;941.1200527506803;6089.086637004485;6133.938660613426;6144.969275153596;6168.506519478431;6302;443.7781109445277;454.1991005662564;460.1257610539934;460.3922821875093;460.5256585716717;4335;4340.218760623118;4345;4398.934015989763;4407.691461597721;10321.74195645115;10837.512311945982;10861.13110951122;10907.890921090846;10932.289401188897;10229.335093218917;10603.204759642904;10689.465526723632;10787.406692631823;10818.621348252773;7776.494527855672;7820.139784623687;7945.920540794518;7969.362451003905;8014.79963000918;6043.7884674036195;6323.36766323364;6355.713992870425;6366.236051673829;6378.2346118466085;10102.69691909244;10203.69388918304;10208.489575521342;10220.897791021995;10232.079112879877;9715.271354648288;10063.39619622825;10125.898741012496;10319.845202321821;10408.635697750542;6929.272426395358;7579.469437139568;7785.416093792875;7797.181295964069;7974.242446967529;8339.332853371594;8351.123132071045;8389.286910612422;8465.28045116172;8489.74530764078;7602.391808655405;7738.458307918391;7744.186860379805;7896.68413263486;7917.604119793872;7391.223921488381;7515.8872616911885;7591.848163036819;7594.658240379306;7719.996400467903;6943.236244013054;7009.754658586925;7034.944758286298;7042.859142817218;7049;4931.654784165074;5019.372578427697;5099.77051032697;5174.767135478837;5179.093658609803;5045.722485263345;5108.10608143566;5110.8466745997675;5125.2568377585785;5167.896642067213 04:58:09 INFO - PROCESS | 14427 | |4;prototype.html;319.4840332862428;321.96327824405404;322.922498600336;338.874616391935;342.20778896853784;5540.750666220019;5631.943680563193;5648.350439699426;5666.9433305666935;5692.573057020724;5532.114861622142;5556.16657501375;5567.2762540869735;5601.467860553251;5602.467765562265;4150.945282085372;4155.563665815092;4234.830606775725;4241.766702831343;4258;4233.280342341809;4235.597618226264;4254.340577210537;4261.318189089746;4287.1425714857;4220.788960551976;4225.894352641193;4253.659707223414;4271.316589345705;4283.336082907154;4088.5911408859174;4226.746395216266;4259.5740425957465;4264.850730224427;4283;3735.308967840931;3765.7175711821724;3782.0733920189455;3803.315403227418;3820.656140947328;5346.224797404355;5348.732563371816;5379.408265090837;5391.191321301797;5404.864878378033;4924.60603151747;4945.823837511483;4988.600911927074;4995.925061124086;5045.4702256262935;5791.449812267828;5820.301563812327;5834.5915785895;5836.620619659709;5864.501517370986;4282.50751163617;4309.418228539138;4322.502912165079;4323.718958267734;4325.805338759764;5890.263717035371;6018.849528761816;6037.516998640098;6117.449429551317;6138.17134686816;4366.585174408489;4368.563143685606;4375.759333236639;4393.494748103945;4399.36209249657;4404.823807047746;4446.666500012512;4455.198064348384;4456.532064133284;4463.866084017484;4843.418789745253;4934.3338649282605;4946.678465899705;4965.528274813887;5014.796448852249;5857.824265272048;5883.882322353615;5886.940350736822;5903.586748927534;5951.464368206795;1539.938402463889;1542.6220575958962;1551.185627545525;1555.5100143454777;1557.6651020030747;969.9515024248759;1001.5843424978698;1003.4180175498193;1011.4588695048114;1012.448215722433;5583.850217666147;5609.467100625434;5642.601894194951;5644.943550564524;5726.455986681259;5849.356570777211;5863.149843272701;5916.5858389913155;5916.7337469813965;5955.213435969278;5338.54622357104;5545.417731138253;5690.971545142248;5740.942590574125;5757.625754326039;3197.728193103566;3205.4390481665614;3218.710316071518;3247.886323978649;3249.7075263226425;6102.816915492543;6119.020956646915;6206.410391012847;6271.686415679198;6368.39500247485;6167.414095660905;6253.874922501524;6257.996161842341;6259.499240060784;6277.2781130170615;6124.663143527059;6253.343398943137;6270.7805226816845;6355.682215889187;6359.554831161774;6010.7677926025935;6014.616638173332;6064.696765161812;6069.908951365821;6084.543659225487;5909.290885093645;5975.282966044103;5995.430434108753;5998.370171131968;6003;5995.070764031582;6251.812445626639;6262.780802671885;6282.1519094921605;6306.211723534559;4250.234957707642;4258.020655249248;4270.50889147752;4300.51632186895;4300.806463709203;5899.882002360015;6069.635821850703;6105.358937311696;6113.358097399709;6158.168647232566;5867.501262392744;5874.706264686663;5911.852203694942;5922.7927022554;5941.792037278675;5827;5881.911771323348;5890.823275301576;5899;5904.173415721716;5435.755391007335;5602.775888964396;5814.604494921273;5836.533077353886;5842.912356314744;5909.261342332208;5929.679379547467;5953.493953013869;5983.760649573968;5984.1921340618455;5640.633358831663;5744.856378590569;5819.970900145472;5820.507695382906;5865.882682346414 04:58:09 INFO - PROCESS | 14427 | |5;yui.html;698.9336013078758;710.4530259021408;741.7144399406227;749.3330935467433;781.8319061401797;13898.791518127236;15263.160526171056;15299.388024479022;15299.84700152998;15389.769153462694;14025.929870350634;14129.505467308647;14130.505432309872;14222.928885355584;14701.117932924006;788.4796034617153;788.5190034079221;793.9523628582275;795.2326005404783;795.3517882925397;768.0936494935974;789.3093543149744;791.6437603078609;792.778022153795;798.3812545277399;838.0906716212917;840.0885039731899;840.1262686805715;841.4698739793921;844.8817165596821;827.7723626002837;827.983440331196;831.8710599857002;833.9249467547919;840.5377042626561;606.7906572232616;608.9573729838913;609.9207103076616;611.7644706787875;613.2855223664426;13999.860001399957;14097.154170749787;14119.223442710647;14145.363458644386;14180.503682371067;13946.23295718735;14321.283935803169;14357.497487587989;14389;14428.783568246485;11746.594329162026;11778.411079445994;11811.468483918245;11816.409179540988;11937.761244775056;3740.382836831947;3747.7001839852746;3757.755745876509;3800.8099595020417;3845.134844659929;76609.61695191544;77209;77288.61355693186;78716.18248976763;78852;10653.733656658645;10783.78432431347;10979.61571345015;10996.560137594406;11081.889181108247;20834.1666333348;20880.433967452198;20883.269085582237;20956.79043209579;21014.684779728315;8074.515529068275;8309.252167304972;8434.57827108642;8560.400771946028;8616.310695144373;4643.164230438553;4705;4761.238201887751;4827.034593081397;4982.626303027215;3688.5204923359793;3785.772853628736;3804.2581696568905;3805.82873770681;3810.028442747082;601.380578004656;609.2780055634088;609.8780243951228;617.8300967233956;637.6747858592058;633.1041576169761;640.3980258556942;683.4259222253231;725.1008749151121;752.4356732450663;9376.48429336393;9475.573599187916;9748.26887983404;9795.314327996972;9940.502974851228;680.0320132029564;688.7968049425332;717.1967396515936;718.737660753821;725.9854802903913;4461.866144015685;4609.53904609543;4658.091672123904;4684.367610372556;4685.695429797052;104218;109385;110656;111718.44140779244;111816;56762.71618641963;56814.147787783215;57920;88698;96156.51921740487;84404;85026.5748671265;85536.14463855406;85669.14330856611;86051;8535.91464085376;8684.869726954226;8713.128687131237;8713.25937295337;8985.101489850962;49768.25347619716;50104;51131.23303150381;51919.48080519297;52326.21510677419;65976;72897.6355118221;72900.63549682217;73346;73413.26586734278;11283.492242849255;11427.885721143015;11481;11654.184207105422;11938.462769175581;12786.552470663482;12833.935830320788;13004.544840930523;13381.53164639233;13498.797518037041;11856.644300670994;12080;12097.81853272184;12491.750164996467;12551;11985;12288.58193381674;12634.936825315815;12724.809127862904;12752.74494510086;11346.375949322866;11825.64523064275;12278;13538.86461135376;13825.723485530434;10301.175905927657;10407.219458540489;10522.421266830397;10541.289211649077;11201.271917325348;11534.13493987971;11759.706007349885;12060.51757929673;12090.818637720617;12142.271463712206 04:58:09 INFO - PROCESS | 14427 | __end_tp_report 04:58:09 INFO - PROCESS | 14427 | __start_cc_report 04:58:09 INFO - PROCESS | 14427 | _x_x_mozilla_cycle_collect,362 04:58:09 INFO - PROCESS | 14427 | __end_cc_report 04:58:09 INFO - PROCESS | 14427 | __startTimestamp1467115089950__endTimestamp 04:58:09 INFO - PROCESS | 14427 | 04:58:09 INFO - PROCESS | 14427 | ------- Summary: start ------- 04:58:09 INFO - PROCESS | 14427 | Number of tests: 6 04:58:09 INFO - PROCESS | 14427 | 04:58:09 INFO - PROCESS | 14427 | [#0] dojo.html Cycles:165 Average:5287.91 Median:5531.20 stddev:696.35 (12.6%) stddev-sans-first:676.48 04:58:09 INFO - PROCESS | 14427 | Values: 3073.9 3128.0 3161.5 3181.3 3181.7 5305.0 5313.0 5364.1 5416.5 5420.1 5222.3 5351.2 5360.7 5366.1 5435.3 4760.4 4795.8 4875.7 4944.5 4964.5 801.3 4841.2 4891.2 4920.3 4962.5 4884.5 4902.1 4903.0 4915.2 4959.3 4775.5 4910.6 4913.5 4946.7 4963.5 4708.1 4720.0 4729.8 4762.8 4768.8 5196.1 5241.0 5268.4 5279.3 5280.4 5645.1 5647.2 5659.5 5673.6 5682.7 5742.1 5746.0 5746.9 5749.1 5790.6 5351.1 5418.4 5425.2 5430.3 5432.7 5763.7 5797.3 5810.0 5817.0 5877.9 5572.9 5623.6 5632.7 5649.6 5654.4 5579.1 5651.9 5656.1 5665.9 5683.1 5625.9 5637.7 5711.1 5733.0 5758.6 5571.9 5671.2 5679.1 5696.1 5771.7 4324.4 4378.1 4391.7 4397.5 4435.3 3884.3 3895.0 3926.6 3932.3 3974.1 5472.2 5472.3 5479.5 5506.6 5508.6 5603.1 5740.3 5768.0 5775.7 5787.6 5499.2 5520.0 5557.5 5560.9 5573.7 4759.0 4780.9 4784.4 4810.9 4827.4 5821.9 5961.7 6030.7 6043.0 6049.5 5826.1 5826.3 5834.1 5839.1 5844.6 6005.0 6005.2 6008.9 6050.8 6066.8 5531.2 5557.5 5574.7 5612.0 5684.7 5681.6 5696.3 5699.6 5706.8 5708.0 5575.5 5588.6 5590.4 5592.1 5608.6 5415.3 5498.5 5520.8 5540.6 5571.0 5309.2 5369.1 5369.9 5371.8 5428.0 5531.4 5578.6 5608.3 5615.4 5668.8 5526.1 5529.9 5530.6 5534.8 5539.8 04:58:09 INFO - PROCESS | 14427 | 04:58:09 INFO - PROCESS | 14427 | [#1] ext.html Cycles:180 Average:60322.03 Median:42482.97 stddev:118268.12 (278.4%) stddev-sans-first:118514.80 04:58:09 INFO - PROCESS | 14427 | Values: 567.1 609.9 617.1 631.5 635.5 41856.2 43175.6 43322.1 43328.4 46606.8 44699.0 45061.0 45571.8 45643.3 45756.8 8629.7 8803.6 8851.9 8868.6 8877.7 8652.0 8784.7 8815.3 8820.0 8832.2 8841.2 8872.0 8874.7 8916.3 8917.9 8755.0 8801.8 8813.0 8830.7 8833.2 8750.9 8760.6 8786.9 8800.6 8816.8 42031.2 42144.8 42473.6 42795.8 42962.8 3393.5 3445.1 3522.2 3583.8 3586.2 29875.9 31868.0 32597.2 32616.8 32757.5 4179.5 4283.3 4373.1 4469.3 4516.5 349635.0 349700.3 350062.0 352058.0 352608.0 60210.0 60758.0 61107.0 61149.0 61451.7 35596.1 63555.4 63583.0 63942.0 63964.0 14557.5 16246.4 16280.3 16326.7 16348.6 12597.6 12673.1 12713.9 12728.5 12814.6 19005.6 19283.7 19391.4 19394.0 19479.0 7280.6 7324.4 7428.4 7503.1 7534.2 1005.6 1022.4 1027.1 1100.8 1162.7 33034.8 33064.0 33083.0 33247.3 33593.8 1100.7 1123.2 1196.0 1219.1 1246.8 17020.4 17066.6 17244.7 17303.9 17339.7 522073.0 525415.0 527642.0 528680.0 529176.0 57977.4 58649.0 58922.4 59116.4 59324.4 1342.5 1343.5 1361.1 1373.0 1377.7 30895.8 32461.7 32546.5 32994.8 33033.8 45812.3 46111.0 46165.5 46172.0 46241.0 440101.0 444405.0 444751.0 445321.0 446754.0 25881.9 25891.6 26164.8 26236.6 26244.9 47506.8 48499.3 48524.3 48682.8 49393.3 40413.2 41272.8 42005.8 42012.8 42492.4 40383.8 40916.6 41112.6 41562.4 41795.8 41550.8 43997.6 44250.3 44491.3 45184.3 35708.8 36181.6 37396.0 39341.0 40508.8 28684.0 29029.0 29144.9 29162.3 29441.7 04:58:09 INFO - PROCESS | 14427 | 04:58:09 INFO - PROCESS | 14427 | [#2] jquery.html Cycles:180 Average:30138.00 Median:32683.34 stddev:78588.52 (240.5%) stddev-sans-first:78777.25 04:58:09 INFO - PROCESS | 14427 | Values: 394.2 394.9 399.5 402.7 414.5 18149.2 19429.4 19689.0 19760.6 20547.8 18141.4 18954.4 19018.2 19466.4 19642.2 5292.8 5393.2 5684.3 5821.1 5832.3 5777.1 5820.4 5830.5 5833.9 5853.7 5250.1 5342.9 5348.7 5354.4 5698.7 5288.1 5308.8 5363.2 5364.5 5371.8 6712.4 7302.5 7322.8 7468.5 7479.7 23956.8 26008.6 26331.3 26874.6 27102.3 2422.7 2432.8 2535.8 2539.4 2576.5 15454.2 16375.8 16460.0 16538.8 16863.0 2053.4 2164.8 2181.7 2213.6 2243.1 92564.1 93564.0 94215.0 94887.5 96594.5 16709.7 17803.9 18442.0 18891.0 18921.5 32345.2 32474.8 32679.7 32687.0 32803.3 9727.5 9911.8 10022.3 10025.6 10283.5 8208.6 8217.9 8284.1 8306.5 8625.7 8765.8 8931.7 8996.1 9259.0 9339.3 3425.7 3426.0 3489.5 3547.3 3681.9 906.4 978.8 1004.8 1035.0 1061.2 18441.2 19314.4 19755.9 20140.6 20493.8 980.9 1002.6 1006.4 1049.6 1054.6 10727.9 11158.8 11167.8 11210.4 11224.3 471969.0 474510.0 476081.0 478541.0 480384.0 81831.0 83206.0 84659.2 94105.0 97504.5 987.8 1035.1 1036.7 1038.4 1056.3 18405.6 18596.0 18658.2 18742.7 18831.2 38045.0 41906.2 42103.0 42464.4 42511.1 47372.5 57911.4 57927.0 58381.7 58795.0 5543.2 5842.2 8990.7 8999.5 9253.7 10356.5 13411.1 14064.5 14097.8 14419.1 12230.6 12260.5 12336.6 12497.3 12514.8 12157.3 12347.0 12468.6 12541.9 12579.6 12453.3 12474.7 12630.0 12675.2 12733.4 8691.2 9060.6 9116.0 9123.7 9255.4 9310.4 11950.3 12241.9 12285.2 12305.8 04:58:09 INFO - PROCESS | 14427 | 04:58:09 INFO - PROCESS | 14427 | [#3] mootools.html Cycles:180 Average:5726.75 Median:4626.03 stddev:3253.94 (70.3%) stddev-sans-first:3247.27 04:58:09 INFO - PROCESS | 14427 | Values: 1460.4 1467.0 1588.3 1725.3 1728.9 7731.4 8353.5 8394.5 8868.9 8894.3 8667.7 8700.9 8764.1 8772.3 8804.6 2254.5 2293.4 2295.3 2300.9 2304.7 2274.6 2285.2 2322.2 2326.0 2328.3 2263.4 2271.1 2280.3 2322.6 2322.8 2227.7 2236.3 2258.0 2263.6 2269.2 2192.9 2243.6 2244.2 2254.9 2269.7 8808.4 8905.7 8909.0 8934.1 8938.9 5038.3 5188.3 5197.7 5213.6 5230.5 3124.5 3133.9 3214.3 3215.2 3230.0 1091.6 1102.2 1123.8 1124.4 1126.9 11613.5 11620.4 11620.8 11639.7 11715.5 4553.9 4555.9 4629.0 4660.1 4686.2 9993.9 9997.8 10006.9 10030.7 10038.5 5080.5 5081.1 5142.5 5160.7 5181.5 4316.4 4623.1 4681.1 4752.3 4785.4 3900.5 3919.7 3999.1 4024.7 4144.8 1202.3 1217.7 1222.8 1235.1 1237.9 786.7 903.1 921.7 928.4 941.1 6089.1 6133.9 6145.0 6168.5 6302.0 443.8 454.2 460.1 460.4 460.5 4335.0 4340.2 4345.0 4398.9 4407.7 10321.7 10837.5 10861.1 10907.9 10932.3 10229.3 10603.2 10689.5 10787.4 10818.6 7776.5 7820.1 7945.9 7969.4 8014.8 6043.8 6323.4 6355.7 6366.2 6378.2 10102.7 10203.7 10208.5 10220.9 10232.1 9715.3 10063.4 10125.9 10319.8 10408.6 6929.3 7579.5 7785.4 7797.2 7974.2 8339.3 8351.1 8389.3 8465.3 8489.7 7602.4 7738.5 7744.2 7896.7 7917.6 7391.2 7515.9 7591.8 7594.7 7720.0 6943.2 7009.8 7034.9 7042.9 7049.0 4931.7 5019.4 5099.8 5174.8 5179.1 5045.7 5108.1 5110.8 5125.3 5167.9 04:58:09 INFO - PROCESS | 14427 | 04:58:09 INFO - PROCESS | 14427 | [#4] prototype.html Cycles:180 Average:4942.44 Median:5620.71 stddev:1460.75 (26.0%) stddev-sans-first:1423.04 04:58:09 INFO - PROCESS | 14427 | Values: 319.5 322.0 322.9 338.9 342.2 5540.8 5631.9 5648.4 5666.9 5692.6 5532.1 5556.2 5567.3 5601.5 5602.5 4150.9 4155.6 4234.8 4241.8 4258.0 4233.3 4235.6 4254.3 4261.3 4287.1 4220.8 4225.9 4253.7 4271.3 4283.3 4088.6 4226.7 4259.6 4264.9 4283.0 3735.3 3765.7 3782.1 3803.3 3820.7 5346.2 5348.7 5379.4 5391.2 5404.9 4924.6 4945.8 4988.6 4995.9 5045.5 5791.4 5820.3 5834.6 5836.6 5864.5 4282.5 4309.4 4322.5 4323.7 4325.8 5890.3 6018.8 6037.5 6117.4 6138.2 4366.6 4368.6 4375.8 4393.5 4399.4 4404.8 4446.7 4455.2 4456.5 4463.9 4843.4 4934.3 4946.7 4965.5 5014.8 5857.8 5883.9 5886.9 5903.6 5951.5 1539.9 1542.6 1551.2 1555.5 1557.7 970.0 1001.6 1003.4 1011.5 1012.4 5583.9 5609.5 5642.6 5644.9 5726.5 5849.4 5863.1 5916.6 5916.7 5955.2 5338.5 5545.4 5691.0 5740.9 5757.6 3197.7 3205.4 3218.7 3247.9 3249.7 6102.8 6119.0 6206.4 6271.7 6368.4 6167.4 6253.9 6258.0 6259.5 6277.3 6124.7 6253.3 6270.8 6355.7 6359.6 6010.8 6014.6 6064.7 6069.9 6084.5 5909.3 5975.3 5995.4 5998.4 6003.0 5995.1 6251.8 6262.8 6282.2 6306.2 4250.2 4258.0 4270.5 4300.5 4300.8 5899.9 6069.6 6105.4 6113.4 6158.2 5867.5 5874.7 5911.9 5922.8 5941.8 5827.0 5881.9 5890.8 5899.0 5904.2 5435.8 5602.8 5814.6 5836.5 5842.9 5909.3 5929.7 5953.5 5983.8 5984.2 5640.6 5744.9 5820.0 5820.5 5865.9 04:58:09 INFO - PROCESS | 14427 | 04:58:09 INFO - PROCESS | 14427 | [#5] yui.html Cycles:180 Average:19520.73 Median:4695.35 stddev:27780.96 (591.7%) stddev-sans-first:27822.95 04:58:09 INFO - PROCESS | 14427 | Values: 698.9 710.5 741.7 749.3 781.8 13898.8 15263.2 15299.4 15299.8 15389.8 14025.9 14129.5 14130.5 14222.9 14701.1 788.5 788.5 794.0 795.2 795.4 768.1 789.3 791.6 792.8 798.4 838.1 840.1 840.1 841.5 844.9 827.8 828.0 831.9 833.9 840.5 606.8 609.0 609.9 611.8 613.3 13999.9 14097.2 14119.2 14145.4 14180.5 13946.2 14321.3 14357.5 14389.0 14428.8 11746.6 11778.4 11811.5 11816.4 11937.8 3740.4 3747.7 3757.8 3800.8 3845.1 76609.6 77209.0 77288.6 78716.2 78852.0 10653.7 10783.8 10979.6 10996.6 11081.9 20834.2 20880.4 20883.3 20956.8 21014.7 8074.5 8309.3 8434.6 8560.4 8616.3 4643.2 4705.0 4761.2 4827.0 4982.6 3688.5 3785.8 3804.3 3805.8 3810.0 601.4 609.3 609.9 617.8 637.7 633.1 640.4 683.4 725.1 752.4 9376.5 9475.6 9748.3 9795.3 9940.5 680.0 688.8 717.2 718.7 726.0 4461.9 4609.5 4658.1 4684.4 4685.7 104218.0 109385.0 110656.0 111718.4 111816.0 56762.7 56814.1 57920.0 88698.0 96156.5 84404.0 85026.6 85536.1 85669.1 86051.0 8535.9 8684.9 8713.1 8713.3 8985.1 49768.3 50104.0 51131.2 51919.5 52326.2 65976.0 72897.6 72900.6 73346.0 73413.3 11283.5 11427.9 11481.0 11654.2 11938.5 12786.6 12833.9 13004.5 13381.5 13498.8 11856.6 12080.0 12097.8 12491.8 12551.0 11985.0 12288.6 12634.9 12724.8 12752.7 11346.4 11825.6 12278.0 13538.9 13825.7 10301.2 10407.2 10522.4 10541.3 11201.3 11534.1 11759.7 12060.5 12090.8 12142.3 04:58:09 INFO - PROCESS | 14427 | -------- Summary: end -------- 04:58:09 INFO - PROCESS | 14427 | 04:58:10 INFO - TEST-INFO | 14427: exit 0 04:58:10 INFO - TEST-OK | dromaeo_css | took 1111354ms 04:58:10 INFO - TEST-START | kraken 04:58:10 INFO - operating with platform_type : linux_ 04:58:10 INFO - Initialising browser for kraken test... 04:58:10 INFO - TEST-INFO | started process 14665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEcizs1/profile http://localhost:56403/getInfo.html) 04:58:15 INFO - PROCESS | 14665 | __metrics Screen width/height:1600/1200 04:58:15 INFO - PROCESS | 14665 | colorDepth:24 04:58:15 INFO - PROCESS | 14665 | Browser inner width/height: 1024/697 04:58:15 INFO - PROCESS | 14665 | __metrics 04:58:15 ERROR - PROCESS | 14665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:58:16 INFO - TEST-INFO | 14665: exit 0 04:58:16 INFO - Browser initialized. 04:58:16 INFO - Running cycle 1/1 for kraken test... 04:58:16 INFO - TEST-INFO | started process 14785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEcizs1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:28 INFO - PROCESS | 14785 | RSS: Main: 184913920 04:58:28 INFO - PROCESS | 14785 | 04:58:31 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56403/tests/kraken/driver.html?testName=audio-beat-detection) 04:58:32 INFO - PROCESS | 14785 | RSS: Main: 190607360 04:58:32 INFO - PROCESS | 14785 | 04:58:34 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56403/tests/kraken/driver.html?testName=audio-dft) 04:58:35 INFO - PROCESS | 14785 | RSS: Main: 189743104 04:58:35 INFO - PROCESS | 14785 | 04:58:38 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56403/tests/kraken/driver.html?testName=audio-fft) 04:58:39 INFO - PROCESS | 14785 | RSS: Main: 184963072 04:58:39 INFO - PROCESS | 14785 | 04:58:41 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56403/tests/kraken/driver.html?testName=audio-oscillator) 04:58:42 INFO - PROCESS | 14785 | RSS: Main: 185987072 04:58:42 INFO - PROCESS | 14785 | 04:58:44 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:58:44 INFO - PROCESS | 14785 | RSS: Main: 186318848 04:58:44 INFO - PROCESS | 14785 | 04:58:47 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56403/tests/kraken/driver.html?testName=imaging-darkroom) 04:58:48 INFO - PROCESS | 14785 | RSS: Main: 186454016 04:58:48 INFO - PROCESS | 14785 | 04:58:52 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56403/tests/kraken/driver.html?testName=imaging-desaturate) 04:58:52 INFO - PROCESS | 14785 | RSS: Main: 183463936 04:58:52 INFO - PROCESS | 14785 | 04:58:55 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56403/tests/kraken/driver.html?testName=json-parse-financial) 04:58:56 INFO - PROCESS | 14785 | RSS: Main: 185073664 04:58:56 INFO - PROCESS | 14785 | 04:58:57 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:58:58 INFO - PROCESS | 14785 | RSS: Main: 185634816 04:58:58 INFO - PROCESS | 14785 | 04:59:00 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:00 INFO - PROCESS | 14785 | RSS: Main: 185720832 04:59:00 INFO - PROCESS | 14785 | 04:59:02 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:03 INFO - PROCESS | 14785 | RSS: Main: 185937920 04:59:03 INFO - PROCESS | 14785 | 04:59:06 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:06 INFO - PROCESS | 14785 | RSS: Main: 186503168 04:59:06 INFO - PROCESS | 14785 | 04:59:09 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:10 INFO - PROCESS | 14785 | RSS: Main: 185880576 04:59:10 INFO - PROCESS | 14785 | 04:59:11 INFO - PROCESS | 14785 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56403/tests/kraken/driver.html?testName=ai-astar) 04:59:11 INFO - PROCESS | 14785 | RSS: Main: 186793984 04:59:11 INFO - PROCESS | 14785 | 04:59:11 INFO - PROCESS | 14785 | __start_tp_report 04:59:11 INFO - PROCESS | 14785 | _x_x_mozilla_page_load 04:59:11 INFO - PROCESS | 14785 | _x_x_mozilla_page_load_details 04:59:11 INFO - PROCESS | 14785 | |i|pagename|runs| 04:59:11 INFO - PROCESS | 14785 | |0;ai-astar;100;110;105;109;110;111;111;109;109;110 04:59:11 INFO - PROCESS | 14785 | |1;audio-beat-detection;151;126;155;178;132;160;153;126;180;136 04:59:11 INFO - PROCESS | 14785 | |2;audio-dft;162;165;164;160;166;176;162;162;160;161 04:59:11 INFO - PROCESS | 14785 | |3;audio-fft;74;75;76;160;75;75;76;75;168;78 04:59:11 INFO - PROCESS | 14785 | |4;audio-oscillator;85;86;144;85;85;85;151;85;87;143 04:59:11 INFO - PROCESS | 14785 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;118;117;117 04:59:11 INFO - PROCESS | 14785 | |6;imaging-darkroom;148;147;148;149;148;147;148;147;147;147 04:59:11 INFO - PROCESS | 14785 | |7;imaging-desaturate;96;96;95;95;96;95;97;96;95;95 04:59:11 INFO - PROCESS | 14785 | |8;json-parse-financial;56;55;58;53;57;54;54;54;55;54 04:59:11 INFO - PROCESS | 14785 | |9;json-stringify-tinderbox;61;62;62;62;63;62;62;61;61;62 04:59:11 INFO - PROCESS | 14785 | |10;stanford-crypto-aes;79;86;80;79;81;81;80;83;94;79 04:59:11 INFO - PROCESS | 14785 | |11;stanford-crypto-ccm;125;129;127;124;127;122;123;124;126;134 04:59:11 INFO - PROCESS | 14785 | |12;stanford-crypto-pbkdf2;159;158;157;156;160;159;160;159;166;164 04:59:11 INFO - PROCESS | 14785 | |13;stanford-crypto-sha256-iterative;65;63;64;71;62;64;62;62;67;62 04:59:11 INFO - PROCESS | 14785 | __end_tp_report 04:59:11 INFO - PROCESS | 14785 | __start_cc_report 04:59:11 INFO - PROCESS | 14785 | _x_x_mozilla_cycle_collect,903 04:59:11 INFO - PROCESS | 14785 | __end_cc_report 04:59:11 INFO - PROCESS | 14785 | __startTimestamp1467115151986__endTimestamp 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | ------- Summary: start ------- 04:59:12 INFO - PROCESS | 14785 | Number of tests: 14 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.41 (3.1%) stddev-sans-first:1.80 04:59:12 INFO - PROCESS | 14785 | Values: 100.0 110.0 105.0 109.0 110.0 111.0 111.0 109.0 109.0 110.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:154.00 stddev:19.69 (12.8%) stddev-sans-first:20.88 04:59:12 INFO - PROCESS | 14785 | Values: 151.0 126.0 155.0 178.0 132.0 160.0 153.0 126.0 180.0 136.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:4.73 (2.9%) stddev-sans-first:4.97 04:59:12 INFO - PROCESS | 14785 | Values: 162.0 165.0 164.0 160.0 166.0 176.0 162.0 162.0 160.0 161.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:37.38 (49.8%) stddev-sans-first:38.99 04:59:12 INFO - PROCESS | 14785 | Values: 74.0 75.0 76.0 160.0 75.0 75.0 76.0 75.0 168.0 78.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:85.00 stddev:29.34 (34.5%) stddev-sans-first:30.34 04:59:12 INFO - PROCESS | 14785 | Values: 85.0 86.0 144.0 85.0 85.0 85.0 151.0 85.0 87.0 143.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:59:12 INFO - PROCESS | 14785 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:59:12 INFO - PROCESS | 14785 | Values: 148.0 147.0 148.0 149.0 148.0 147.0 148.0 147.0 147.0 147.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:59:12 INFO - PROCESS | 14785 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 97.0 96.0 95.0 95.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.56 (2.8%) stddev-sans-first:1.62 04:59:12 INFO - PROCESS | 14785 | Values: 56.0 55.0 58.0 53.0 57.0 54.0 54.0 54.0 55.0 54.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 04:59:12 INFO - PROCESS | 14785 | Values: 61.0 62.0 62.0 62.0 63.0 62.0 62.0 61.0 61.0 62.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:81.00 stddev:4.69 (5.8%) stddev-sans-first:4.82 04:59:12 INFO - PROCESS | 14785 | Values: 79.0 86.0 80.0 79.0 81.0 81.0 80.0 83.0 94.0 79.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:126.50 stddev:3.48 (2.7%) stddev-sans-first:3.67 04:59:12 INFO - PROCESS | 14785 | Values: 125.0 129.0 127.0 124.0 127.0 122.0 123.0 124.0 126.0 134.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:159.50 stddev:3.05 (1.9%) stddev-sans-first:3.22 04:59:12 INFO - PROCESS | 14785 | Values: 159.0 158.0 157.0 156.0 160.0 159.0 160.0 159.0 166.0 164.0 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - PROCESS | 14785 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:2.90 (4.5%) stddev-sans-first:3.06 04:59:12 INFO - PROCESS | 14785 | Values: 65.0 63.0 64.0 71.0 62.0 64.0 62.0 62.0 67.0 62.0 04:59:12 INFO - PROCESS | 14785 | -------- Summary: end -------- 04:59:12 INFO - PROCESS | 14785 | 04:59:12 INFO - TEST-INFO | 14785: exit 0 04:59:13 INFO - TEST-OK | kraken | took 62388ms 04:59:13 INFO - SUITE-END | took 1173s 04:59:13 INFO - Completed test suite (00:19:33) 04:59:13 INFO - javascript benchmark 04:59:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7368.746679353352, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.8770449182034, 3127.968720312796, 3161.541576471411, 3181.3319202967377, 3181.6818318168184, 5304.973475132619, 5313.043652142617, 5364.088105022146, 5416.458354164582, 5420.051490989071, 5222.294990176325, 5351.170568561869, 5360.65155764875, 5366.06093933562, 5435.266239057726, 4760.3573517575205, 4795.808167673289, 4875.731834749087, 4944.505549445044, 4964.528369804881, 801.3282649539043, 4841.2012018016985, 4891.241857512074, 4920.261960705905, 4962.528559786814, 4884.535969082932, 4902.092977961548, 4902.975485122587, 4915.16442204826, 4959.256111583255, 4775.498572649856, 4910.631702622282, 4913.484084171182, 4946.653734238605, 4963.503649635044, 4708.058388322315, 4720.0, 4729.834455794065, 4762.809487620491, 4768.833090841838, 5196.142636464979, 5240.973795131038, 5268.420473747885, 5279.287296215, 5280.419153893069, 5645.096784514499, 5647.152927060933, 5659.547236221092, 5673.63121397112, 5682.7442765075675, 5742.138679198112, 5746.0, 5746.9425305747245, 5749.0514065179195, 5790.565707571906, 5351.063563876306, 5418.376886658006, 5425.186222066722, 5430.348358197002, 5432.728363581805, 5763.682997435181, 5797.275340582427, 5810.0, 5817.0, 5877.853053673693, 5572.86067848307, 5623.606347555632, 5632.746526406321, 5649.576281778883, 5654.434556544395, 5579.0515612346, 5651.858703532444, 5656.095024796013, 5665.858353541194, 5683.119116536861, 5625.8593535161945, 5637.718114094361, 5711.057675483582, 5733.0, 5758.596898217084, 5571.860703482445, 5671.234383358194, 5679.148127780783, 5696.088625819849, 5771.740271687784, 4324.437823082979, 4378.08060307339, 4391.736495810262, 4397.516273209944, 4435.268180750205, 3884.2814079395403, 3894.9610503894596, 3926.6466018058513, 3932.3315036443873, 3974.066094467798, 5472.151816468454, 5472.288602481652, 5479.5342395896, 5506.64206826555, 5508.614396992252, 5603.131514615241, 5740.326191237611, 5768.048272035151, 5775.682337471395, 5787.565932555075, 5499.175123731472, 5520.0, 5557.472040156179, 5560.944390556043, 5573.665580065209, 4759.0, 4780.856574302777, 4784.425868895755, 4810.879728006757, 4827.42070951488, 5821.883562328814, 5961.731722072517, 6030.728617212236, 6043.0, 6049.5462840287155, 5826.096954972071, 5826.329972053268, 5834.066549352253, 5839.065749480063, 5844.561657875592, 6004.969975150097, 6005.219321488178, 6008.939910600838, 6050.84872878164, 6066.787662431793, 5531.197976293495, 5557.499825015606, 5574.721263936706, 5612.0, 5684.687342196219, 5681.573881958787, 5696.344920334049, 5699.5725320600295, 5706.771729130955, 5708.0, 5575.526080283222, 5588.580856435865, 5590.413006634245, 5592.105263157875, 5608.6073974821375, 5415.288350404609, 5498.477644623755, 5520.779168833202, 5540.612157148961, 5571.0, 5309.177077552986, 5369.1140961740875, 5369.865753356197, 5371.785128594969, 5428.0, 5531.446855314597, 5578.63738856973, 5608.327000759772, 5615.438456154352, 5668.773249069991, 5526.06056970308, 5529.944700552943, 5530.55755539564, 5534.750936207961, 5539.806106786243], "value": 5243.436176706542, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.0700051914861, 609.8871708733884, 617.0682269772648, 631.5452873930772, 635.4725577770452, 41856.16287674245, 43175.56824431759, 43322.13355732884, 43328.35007474883, 46606.7669661652, 44699.0, 45061.0, 45571.77214113925, 45643.31535026969, 45756.771216143956, 8629.741107766762, 8803.603837827313, 8851.911480885205, 8868.600912958933, 8877.668349747557, 8652.0, 8784.692535761249, 8815.294776417872, 8820.029796722356, 8832.249258813008, 8841.248493878029, 8872.0, 8874.733757987271, 8916.331275154356, 8917.866232006525, 8754.956225218864, 8801.823963520726, 8813.030566637664, 8830.735077947671, 8833.249173820233, 8750.86873696895, 8760.649574017032, 8786.86819697705, 8800.603972821174, 8816.779580510474, 42031.1593768126, 42144.78927605373, 42473.57526424727, 42795.78602107001, 42962.78518607418, 3393.5079413484905, 3445.104272889042, 3522.154682876117, 3583.7849729016084, 3586.22896077342, 29875.850620746973, 31868.0, 32597.185070373194, 32616.836915815507, 32757.508637370458, 4179.540250572434, 4283.250431174563, 4373.103513779699, 4469.307257375112, 4516.458025036984, 349635.0, 349700.2514987434, 350062.0, 352058.0, 352608.0, 60210.0, 60758.0, 61107.0, 61149.0, 61451.6927415369, 35596.110097247256, 63555.36444635587, 63583.046254306224, 63942.0, 63964.0, 14557.490487832874, 16246.431374902058, 16280.348786048662, 16326.673466530603, 16348.591285217964, 12597.559085431965, 12673.112882098165, 12713.936430317974, 12728.490860365482, 12814.615561533168, 19005.619887602446, 19283.710744338845, 19391.4182574523, 19394.0, 19479.0, 7280.563166210044, 7324.4140468763435, 7428.405727541784, 7503.137139229058, 7534.171241163468, 1005.6178652112151, 1022.437659287389, 1027.091024443373, 1100.8403781451646, 1162.7384288047394, 33034.8348258262, 33064.0, 33083.0, 33247.3350532988, 33593.83203083969, 1100.6808025672626, 1123.1913022623698, 1196.0398014913194, 1219.1039585904352, 1246.7506498700116, 17020.404285849934, 17066.573335666708, 17244.741328880078, 17303.91348043277, 17339.653206936044, 522073.0, 525415.0, 527642.0, 528680.0, 529176.0, 57977.42022579804, 58649.0, 58922.41077589255, 59116.40883591195, 59324.40675593275, 1342.4563051963971, 1343.5431953135785, 1361.0540674231513, 1372.9656758580916, 1377.7175678985784, 30895.84552077225, 32461.67538324681, 32546.511802323457, 32994.84827729989, 33033.83483082569, 45812.31281530846, 46111.0, 46165.53834461747, 46172.0, 46241.0, 440101.0, 444405.0, 444751.0, 445321.0, 446754.0, 25881.870590646926, 25891.61162582525, 26164.82258298419, 26236.60645090287, 26244.868775656, 47506.76246618745, 48499.27251091166, 48524.27213591729, 48682.75658621826, 49393.25910111423, 40413.191736164525, 41272.79363603163, 42005.78997104995, 42012.789936050125, 42492.36261456019, 40383.79808100941, 40916.590834092465, 41112.58887411207, 41562.37656435216, 41795.7910210447, 41550.792246038574, 43997.56002439935, 44250.33624495571, 44491.33263000993, 45184.32223516584, 35708.821455892554, 36181.638183617826, 37396.0, 39341.0, 40508.79745601253, 28684.0, 29029.0, 29144.854275728485, 29162.338275568512, 29441.705582943898], "value": 20216.6755963746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.24502078519635, 394.8657456464803, 399.5265610251852, 402.71004876488917, 414.5046669230269, 18149.183286752093, 19429.417117486497, 19689.0, 19760.604787904253, 20547.794522054774, 18141.365052223176, 18954.43136705901, 19018.2392704292, 19466.416007519798, 19642.214311427524, 5292.788288468457, 5393.217983392406, 5684.289463817023, 5821.068629019358, 5832.270966129234, 5777.104548794922, 5820.35976042635, 5830.475257226849, 5833.912491312633, 5853.678047707374, 5250.081235783741, 5342.866428339284, 5348.732563371836, 5354.41101478837, 5698.746275819313, 5288.0745869472885, 5308.787648494055, 5363.19552067193, 5364.490373414539, 5371.785128594852, 6712.39588437043, 7302.488825782198, 7322.81692957675, 7468.5145465544565, 7479.663415146331, 23956.803628335332, 26008.609870851953, 26331.34171645705, 26874.5968810468, 27102.322441939108, 2422.6729391532094, 2432.768886955754, 2535.7971362291155, 2539.4032402385424, 2576.4589436218416, 15454.1500217488, 16375.754363684555, 16460.0, 16538.83461165385, 16863.0, 2053.414776788608, 2164.7726988666122, 2181.7054697615777, 2213.557288542282, 2243.1027588964544, 92564.07435925622, 93564.0, 94215.0, 94887.52556237244, 96594.51702741512, 16709.665806684043, 17803.910980445016, 18442.0, 18891.0, 18921.526961825788, 32345.191370215933, 32474.837625812193, 32679.67320326814, 32687.0, 32803.34393312121, 9727.464989425649, 9911.752206194902, 10022.298439109192, 10025.649102281532, 10283.537240824031, 8208.58957052157, 8217.917820821835, 8284.053247486836, 8306.501609903304, 8625.69810056645, 8765.824683506295, 8931.687390941415, 8996.145366190201, 9259.027802080684, 9339.272234636614, 3425.7088147507743, 3425.9828700856833, 3489.45913383426, 3547.2728090741853, 3681.9263614727556, 906.3610154840821, 978.8091322192247, 1004.8141093897506, 1034.9534270957824, 1061.156380677348, 18441.1701473434, 19314.420567383, 19755.901220493804, 20140.597188056156, 20493.79506204919, 980.9166220871306, 1002.6490728245202, 1006.3760468509424, 1049.5644307612408, 1054.5676272728144, 10727.892721072845, 11158.776824463464, 11167.83248251277, 11210.439478026066, 11224.326540407601, 471969.0, 474510.0, 476081.0, 478541.0, 480384.0, 81831.0, 83206.0, 84659.15340846636, 94105.0, 97504.51247743858, 987.76293689514, 1035.13566172247, 1036.6734478639205, 1038.3665963762098, 1056.2975621211808, 18405.63188736191, 18596.0, 18658.16038278308, 18742.68801183904, 18831.24675012984, 38045.0, 41906.161876762904, 42103.0, 42464.36303455389, 42511.1497770049, 47372.52627473819, 57911.420885792286, 57927.0, 58381.70809145927, 58795.0, 5543.1962365455975, 5842.159719688285, 8990.68532601382, 8999.460032398078, 9253.67612133572, 10356.482175891326, 13411.128276661986, 14064.507742228972, 14097.788533171806, 14419.134851908919, 12230.633081007583, 12260.509579617072, 12336.568220112253, 12497.25016499013, 12514.812277816021, 12157.331346776013, 12347.0, 12468.563600273947, 12541.874581254435, 12579.622611321674, 12453.315067671365, 12474.688132796753, 12630.0, 12675.239485630891, 12733.363331833187, 8691.217790398894, 9060.637574496946, 9115.96731974302, 9123.680671176477, 9255.35212535116, 9310.394824336396, 11950.34273114987, 12241.938790305992, 12285.201461904948, 12305.815412768994], "value": 10312.89222872338, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.364741337518, 1467.0, 1588.2693960778042, 1725.3357457378906, 1728.9453433405613, 7731.420143489247, 8353.540555269457, 8394.454360466572, 8868.866966995492, 8894.332925030632, 8667.69663061793, 8700.912990870089, 8764.079771623983, 8772.254358379529, 8804.64781408743, 2254.458929856835, 2293.392251053472, 2295.3228797504776, 2300.919467818627, 2304.665823455598, 2274.601944659678, 2285.1773361589812, 2322.210448447536, 2325.965110523335, 2328.3131476214558, 2263.4454558633156, 2271.068861766676, 2280.2589158523465, 2322.5587138443725, 2322.756110608387, 2227.654713519407, 2236.317923033474, 2258.0, 2263.6038693228784, 2269.1830940861196, 2192.9451763705874, 2243.5849367866836, 2244.236959433784, 2254.943626409353, 2269.727632684072, 8808.383413161082, 8905.688300909502, 8908.955455222747, 8934.10658934108, 8938.910610893872, 5038.294638750578, 5188.325517682715, 5197.662151960149, 5213.582913366921, 5230.476952304739, 3124.500239884845, 3133.9059828204963, 3214.324991751735, 3215.1962009497624, 3229.9677003229904, 1091.6015654286127, 1102.1513434655271, 1123.7527743896412, 1124.3759713359082, 1126.881677423867, 11613.535458581646, 11620.418979051014, 11620.767584648343, 11639.6508104757, 11715.472803723767, 4553.908921821545, 4555.908881822411, 4629.0, 4660.13787449323, 4686.226772582554, 9993.900060999442, 9997.80004399908, 10006.949965250273, 10030.699079027641, 10038.548265328078, 5080.491950804964, 5081.060003899291, 5142.51146141116, 5160.716160611128, 5181.53366197044, 4316.438862947797, 4623.052274283831, 4681.063787242497, 4752.334673145762, 4785.353977213102, 3900.4539364488996, 3919.7256192066284, 3999.0802115513593, 4024.7182697210915, 4144.79276036203, 1202.3146806320487, 1217.7260116473722, 1222.7615614954998, 1235.123062625546, 1237.9195352302072, 786.697121608185, 903.1440389998485, 921.7188757428914, 928.4475736936512, 941.1200527506803, 6089.086637004485, 6133.938660613426, 6144.969275153596, 6168.506519478431, 6302.0, 443.7781109445277, 454.1991005662564, 460.1257610539934, 460.3922821875093, 460.5256585716717, 4335.0, 4340.218760623118, 4345.0, 4398.934015989763, 4407.691461597721, 10321.74195645115, 10837.512311945982, 10861.13110951122, 10907.890921090846, 10932.289401188897, 10229.335093218917, 10603.204759642904, 10689.465526723632, 10787.406692631823, 10818.621348252773, 7776.494527855672, 7820.139784623687, 7945.920540794518, 7969.362451003905, 8014.79963000918, 6043.7884674036195, 6323.36766323364, 6355.713992870425, 6366.236051673829, 6378.2346118466085, 10102.69691909244, 10203.69388918304, 10208.489575521342, 10220.897791021995, 10232.079112879877, 9715.271354648288, 10063.39619622825, 10125.898741012496, 10319.845202321821, 10408.635697750542, 6929.272426395358, 7579.469437139568, 7785.416093792875, 7797.181295964069, 7974.242446967529, 8339.332853371594, 8351.123132071045, 8389.286910612422, 8465.28045116172, 8489.74530764078, 7602.391808655405, 7738.458307918391, 7744.186860379805, 7896.68413263486, 7917.604119793872, 7391.223921488381, 7515.8872616911885, 7591.848163036819, 7594.658240379306, 7719.996400467903, 6943.236244013054, 7009.754658586925, 7034.944758286298, 7042.859142817218, 7049.0, 4931.654784165074, 5019.372578427697, 5099.77051032697, 5174.767135478837, 5179.093658609803, 5045.722485263345, 5108.10608143566, 5110.8466745997675, 5125.2568377585785, 5167.896642067213], "value": 4499.6503006409785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.4840332862428, 321.96327824405404, 322.922498600336, 338.874616391935, 342.20778896853784, 5540.750666220019, 5631.943680563193, 5648.350439699426, 5666.9433305666935, 5692.573057020724, 5532.114861622142, 5556.16657501375, 5567.2762540869735, 5601.467860553251, 5602.467765562265, 4150.945282085372, 4155.563665815092, 4234.830606775725, 4241.766702831343, 4258.0, 4233.280342341809, 4235.597618226264, 4254.340577210537, 4261.318189089746, 4287.1425714857, 4220.788960551976, 4225.894352641193, 4253.659707223414, 4271.316589345705, 4283.336082907154, 4088.5911408859174, 4226.746395216266, 4259.5740425957465, 4264.850730224427, 4283.0, 3735.308967840931, 3765.7175711821724, 3782.0733920189455, 3803.315403227418, 3820.656140947328, 5346.224797404355, 5348.732563371816, 5379.408265090837, 5391.191321301797, 5404.864878378033, 4924.60603151747, 4945.823837511483, 4988.600911927074, 4995.925061124086, 5045.4702256262935, 5791.449812267828, 5820.301563812327, 5834.5915785895, 5836.620619659709, 5864.501517370986, 4282.50751163617, 4309.418228539138, 4322.502912165079, 4323.718958267734, 4325.805338759764, 5890.263717035371, 6018.849528761816, 6037.516998640098, 6117.449429551317, 6138.17134686816, 4366.585174408489, 4368.563143685606, 4375.759333236639, 4393.494748103945, 4399.36209249657, 4404.823807047746, 4446.666500012512, 4455.198064348384, 4456.532064133284, 4463.866084017484, 4843.418789745253, 4934.3338649282605, 4946.678465899705, 4965.528274813887, 5014.796448852249, 5857.824265272048, 5883.882322353615, 5886.940350736822, 5903.586748927534, 5951.464368206795, 1539.938402463889, 1542.6220575958962, 1551.185627545525, 1555.5100143454777, 1557.6651020030747, 969.9515024248759, 1001.5843424978698, 1003.4180175498193, 1011.4588695048114, 1012.448215722433, 5583.850217666147, 5609.467100625434, 5642.601894194951, 5644.943550564524, 5726.455986681259, 5849.356570777211, 5863.149843272701, 5916.5858389913155, 5916.7337469813965, 5955.213435969278, 5338.54622357104, 5545.417731138253, 5690.971545142248, 5740.942590574125, 5757.625754326039, 3197.728193103566, 3205.4390481665614, 3218.710316071518, 3247.886323978649, 3249.7075263226425, 6102.816915492543, 6119.020956646915, 6206.410391012847, 6271.686415679198, 6368.39500247485, 6167.414095660905, 6253.874922501524, 6257.996161842341, 6259.499240060784, 6277.2781130170615, 6124.663143527059, 6253.343398943137, 6270.7805226816845, 6355.682215889187, 6359.554831161774, 6010.7677926025935, 6014.616638173332, 6064.696765161812, 6069.908951365821, 6084.543659225487, 5909.290885093645, 5975.282966044103, 5995.430434108753, 5998.370171131968, 6003.0, 5995.070764031582, 6251.812445626639, 6262.780802671885, 6282.1519094921605, 6306.211723534559, 4250.234957707642, 4258.020655249248, 4270.50889147752, 4300.51632186895, 4300.806463709203, 5899.882002360015, 6069.635821850703, 6105.358937311696, 6113.358097399709, 6158.168647232566, 5867.501262392744, 5874.706264686663, 5911.852203694942, 5922.7927022554, 5941.792037278675, 5827.0, 5881.911771323348, 5890.823275301576, 5899.0, 5904.173415721716, 5435.755391007335, 5602.775888964396, 5814.604494921273, 5836.533077353886, 5842.912356314744, 5909.261342332208, 5929.679379547467, 5953.493953013869, 5983.760649573968, 5984.1921340618455, 5640.633358831663, 5744.856378590569, 5819.970900145472, 5820.507695382906, 5865.882682346414], "value": 4472.279407582042, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.9336013078758, 710.4530259021408, 741.7144399406227, 749.3330935467433, 781.8319061401797, 13898.791518127236, 15263.160526171056, 15299.388024479022, 15299.84700152998, 15389.769153462694, 14025.929870350634, 14129.505467308647, 14130.505432309872, 14222.928885355584, 14701.117932924006, 788.4796034617153, 788.5190034079221, 793.9523628582275, 795.2326005404783, 795.3517882925397, 768.0936494935974, 789.3093543149744, 791.6437603078609, 792.778022153795, 798.3812545277399, 838.0906716212917, 840.0885039731899, 840.1262686805715, 841.4698739793921, 844.8817165596821, 827.7723626002837, 827.983440331196, 831.8710599857002, 833.9249467547919, 840.5377042626561, 606.7906572232616, 608.9573729838913, 609.9207103076616, 611.7644706787875, 613.2855223664426, 13999.860001399957, 14097.154170749787, 14119.223442710647, 14145.363458644386, 14180.503682371067, 13946.23295718735, 14321.283935803169, 14357.497487587989, 14389.0, 14428.783568246485, 11746.594329162026, 11778.411079445994, 11811.468483918245, 11816.409179540988, 11937.761244775056, 3740.382836831947, 3747.7001839852746, 3757.755745876509, 3800.8099595020417, 3845.134844659929, 76609.61695191544, 77209.0, 77288.61355693186, 78716.18248976763, 78852.0, 10653.733656658645, 10783.78432431347, 10979.61571345015, 10996.560137594406, 11081.889181108247, 20834.1666333348, 20880.433967452198, 20883.269085582237, 20956.79043209579, 21014.684779728315, 8074.515529068275, 8309.252167304972, 8434.57827108642, 8560.400771946028, 8616.310695144373, 4643.164230438553, 4705.0, 4761.238201887751, 4827.034593081397, 4982.626303027215, 3688.5204923359793, 3785.772853628736, 3804.2581696568905, 3805.82873770681, 3810.028442747082, 601.380578004656, 609.2780055634088, 609.8780243951228, 617.8300967233956, 637.6747858592058, 633.1041576169761, 640.3980258556942, 683.4259222253231, 725.1008749151121, 752.4356732450663, 9376.48429336393, 9475.573599187916, 9748.26887983404, 9795.314327996972, 9940.502974851228, 680.0320132029564, 688.7968049425332, 717.1967396515936, 718.737660753821, 725.9854802903913, 4461.866144015685, 4609.53904609543, 4658.091672123904, 4684.367610372556, 4685.695429797052, 104218.0, 109385.0, 110656.0, 111718.44140779244, 111816.0, 56762.71618641963, 56814.147787783215, 57920.0, 88698.0, 96156.51921740487, 84404.0, 85026.5748671265, 85536.14463855406, 85669.14330856611, 86051.0, 8535.91464085376, 8684.869726954226, 8713.128687131237, 8713.25937295337, 8985.101489850962, 49768.25347619716, 50104.0, 51131.23303150381, 51919.48080519297, 52326.21510677419, 65976.0, 72897.6355118221, 72900.63549682217, 73346.0, 73413.26586734278, 11283.492242849255, 11427.885721143015, 11481.0, 11654.184207105422, 11938.462769175581, 12786.552470663482, 12833.935830320788, 13004.544840930523, 13381.53164639233, 13498.797518037041, 11856.644300670994, 12080.0, 12097.81853272184, 12491.750164996467, 12551.0, 11985.0, 12288.58193381674, 12634.936825315815, 12724.809127862904, 12752.74494510086, 11346.375949322866, 11825.64523064275, 12278.0, 13538.86461135376, 13825.723485530434, 10301.175905927657, 10407.219458540489, 10522.421266830397, 10541.289211649077, 11201.271917325348, 11534.13493987971, 11759.706007349885, 12060.51757929673, 12090.818637720617, 12142.271463712206], "value": 7276.152025481343, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 105.0, 109.0, 110.0, 111.0, 111.0, 109.0, 109.0, 110.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 155.0, 178.0, 132.0, 160.0, 153.0, 126.0, 180.0, 136.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 164.0, 160.0, 166.0, 176.0, 162.0, 162.0, 160.0, 161.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 160.0, 75.0, 75.0, 76.0, 75.0, 168.0, 78.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 144.0, 85.0, 85.0, 85.0, 151.0, 85.0, 87.0, 143.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 149.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 97.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 58.0, 53.0, 57.0, 54.0, 54.0, 54.0, 55.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 61.0, 61.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 80.0, 79.0, 81.0, 81.0, 80.0, 83.0, 94.0, 79.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 129.0, 127.0, 124.0, 127.0, 122.0, 123.0, 124.0, 126.0, 134.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 157.0, 156.0, 160.0, 159.0, 160.0, 159.0, 166.0, 164.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 71.0, 62.0, 64.0, 62.0, 62.0, 67.0, 62.0], "value": 64.2, "unit": "score"}]}]} 04:59:13 INFO - Return code: 0 04:59:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:59:13 ERROR - # TBPL SUCCESS # 04:59:13 INFO - Running post-action listener: _resource_record_post_action 04:59:13 INFO - ##### 04:59:13 INFO - ##### Finished run-tests step (success) 04:59:13 INFO - ##### 04:59:13 INFO - Running post-run listener: _resource_record_post_run 04:59:13 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 416477184; Read time: 88; Write time: 331280 04:59:13 INFO - TinderboxPrint: CPU usage
13.4% 04:59:13 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 88 04:59:13 INFO - TinderboxPrint: I/O write bytes / time
416,477,184 / 331,280 04:59:13 INFO - TinderboxPrint: CPU idle
8,231.7 (86.6%) 04:59:13 INFO - TinderboxPrint: CPU user
1,219.9 (12.8%) 04:59:13 INFO - TinderboxPrint: Swap in / out
0 / 0 04:59:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109813760; Read time: 0; Write time: 113300 04:59:13 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295436288; Read time: 88; Write time: 193940 04:59:13 INFO - Running post-run listener: _upload_blobber_files 04:59:13 INFO - Blob upload gear active. 04:59:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:13 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 04:59:13 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'] 04:59:13 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 04:59:14 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:59:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:59:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:21 INFO - (blobuploader) - INFO - Done attempting. 04:59:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:59:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:59:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:22 INFO - (blobuploader) - INFO - Done attempting. 04:59:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:59:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:59:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:23 INFO - (blobuploader) - INFO - Done attempting. 04:59:23 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:23 INFO - Return code: 0 04:59:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9416c527d4d27ab75e3fbf466b7b5915386d0d7544ecf21968d1bad196a45e7c3a7f71d108fe0333a05f5fa8e3cb4278210b684d3eea93db1aeb0fd211af7a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3128229beef8d6ceac304415119568a4144c772ecdbbd99955475ca67b87b5b1337c1bfe65a246ad83aa71c465d5eacbbfa26e42e62e0b4b8207f54ab6c989e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/510f4915ba2794355ab971312b2515865441e1b515eb7b44dcc8f40568933c426482cfe8d8ec495ed6a19e500d01ede2d4f8870522e93d725f055a2df8611d82"} 04:59:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:23 INFO - Contents: 04:59:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9416c527d4d27ab75e3fbf466b7b5915386d0d7544ecf21968d1bad196a45e7c3a7f71d108fe0333a05f5fa8e3cb4278210b684d3eea93db1aeb0fd211af7a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3128229beef8d6ceac304415119568a4144c772ecdbbd99955475ca67b87b5b1337c1bfe65a246ad83aa71c465d5eacbbfa26e42e62e0b4b8207f54ab6c989e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/510f4915ba2794355ab971312b2515865441e1b515eb7b44dcc8f40568933c426482cfe8d8ec495ed6a19e500d01ede2d4f8870522e93d725f055a2df8611d82"} 04:59:23 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:23 INFO - Copying logs to upload dir... 04:59:23 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.281656 ========= master_lag: 79.57 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2016-06-28 05:00:42.871932) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-06-28 05:00:42.878455) ========= 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=232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9416c527d4d27ab75e3fbf466b7b5915386d0d7544ecf21968d1bad196a45e7c3a7f71d108fe0333a05f5fa8e3cb4278210b684d3eea93db1aeb0fd211af7a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3128229beef8d6ceac304415119568a4144c772ecdbbd99955475ca67b87b5b1337c1bfe65a246ad83aa71c465d5eacbbfa26e42e62e0b4b8207f54ab6c989e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/510f4915ba2794355ab971312b2515865441e1b515eb7b44dcc8f40568933c426482cfe8d8ec495ed6a19e500d01ede2d4f8870522e93d725f055a2df8611d82"} build_url:https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9416c527d4d27ab75e3fbf466b7b5915386d0d7544ecf21968d1bad196a45e7c3a7f71d108fe0333a05f5fa8e3cb4278210b684d3eea93db1aeb0fd211af7a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3128229beef8d6ceac304415119568a4144c772ecdbbd99955475ca67b87b5b1337c1bfe65a246ad83aa71c465d5eacbbfa26e42e62e0b4b8207f54ab6c989e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/510f4915ba2794355ab971312b2515865441e1b515eb7b44dcc8f40568933c426482cfe8d8ec495ed6a19e500d01ede2d4f8870522e93d725f055a2df8611d82"}' ========= master_lag: 1.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-06-28 05:00:44.011178) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-06-28 05:00:44.011493) ========= 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=232498196343f89f466a4a9a000001c8-1467113919.678511-1494663480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 4.52 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-06-28 05:00:48.534335) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-06-28 05:00:48.534628) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-06-28 05:00:49.837492) ========= ========= Total master_lag: 85.27 =========