builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1465858405.4 results: success (0) buildid: 20160613144126 builduid: c420b1a61da64fa8abaca2d48d0b63c9 revision: cb5eccf28d080455a62d3b09f8b698c6bc306774 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:25.399338) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:25.399766) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:25.401211) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:25.423512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:25.423780) ========= 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=df17445c3590ff7897617a0e00000225-1465858162.530165-834287790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 15:53:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-06-13 15:53:25 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095539 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:25.532893) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:25.533214) ========= 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=df17445c3590ff7897617a0e00000225-1465858162.530165-834287790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019247 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:25.583170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:25.583517) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cb5eccf28d080455a62d3b09f8b698c6bc306774 --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 cb5eccf28d080455a62d3b09f8b698c6bc306774 --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=df17445c3590ff7897617a0e00000225-1465858162.530165-834287790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 15:53:25,809 truncating revision to first 12 chars 2016-06-13 15:53:25,809 Setting DEBUG logging. 2016-06-13 15:53:25,809 attempt 1/10 2016-06-13 15:53:25,809 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cb5eccf28d08?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 15:53:26,263 unpacking tar archive at: fx-team-cb5eccf28d08/testing/mozharness/ program finished with exit code 0 elapsedTime=0.792220 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:26.388907) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:26.389230) ========= script_repo_revision: cb5eccf28d080455a62d3b09f8b698c6bc306774 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:26.389620) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:26.389883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 15:53:26.400167) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-13 15:53:26.400431) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=df17445c3590ff7897617a0e00000225-1465858162.530165-834287790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:53:26 INFO - MultiFileLogger online at 20160613 15:53:26 in /builds/slave/test 15:53:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:53:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:53:26 INFO - {'append_to_log': False, 15:53:26 INFO - 'base_work_dir': '/builds/slave/test', 15:53:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:53:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:53:26 INFO - 'branch': 'Fx-Team-Non-PGO', 15:53:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:53:26 INFO - 'config_files': ('talos/linux_config.py',), 15:53:26 INFO - 'default_actions': ('clobber', 15:53:26 INFO - 'read-buildbot-config', 15:53:26 INFO - 'download-and-extract', 15:53:26 INFO - 'populate-webroot', 15:53:26 INFO - 'create-virtualenv', 15:53:26 INFO - 'install', 15:53:26 INFO - 'run-tests'), 15:53:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:53:26 INFO - 'download_minidump_stackwalk': True, 15:53:26 INFO - 'download_symbols': 'ondemand', 15:53:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:53:26 INFO - 'tooltool.py': '/tools/tooltool.py', 15:53:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:53:26 INFO - '/tools/misc-python/virtualenv.py')}, 15:53:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:53:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:53:26 INFO - 'installer_path': 'installer.exe', 15:53:26 INFO - 'log_level': 'info', 15:53:26 INFO - 'log_name': 'talos', 15:53:26 INFO - 'log_to_console': True, 15:53:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:53:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:53:26 INFO - 'opt_config_files': (), 15:53:26 INFO - 'pip_index': False, 15:53:26 INFO - 'sps_profile': False, 15:53:26 INFO - 'sps_profile_interval': 0, 15:53:26 INFO - 'suite': 'dromaeojs', 15:53:26 INFO - 'system_bits': '32', 15:53:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:53:26 INFO - 'title': 'talos-linux64-ix-021', 15:53:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:53:26 INFO - 'use_talos_json': True, 15:53:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:53:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:53:26 INFO - 'work_dir': 'build'} 15:53:26 INFO - ##### 15:53:26 INFO - ##### Running clobber step. 15:53:26 INFO - ##### 15:53:26 INFO - Running pre-action listener: _resource_record_pre_action 15:53:26 INFO - Running main action method: clobber 15:53:26 INFO - rmtree: /builds/slave/test/build 15:53:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:53:27 INFO - Running post-action listener: _resource_record_post_action 15:53:27 INFO - ##### 15:53:27 INFO - ##### Finished clobber step (success) 15:53:27 INFO - ##### 15:53:27 INFO - ##### 15:53:27 INFO - ##### Running read-buildbot-config step. 15:53:27 INFO - ##### 15:53:27 INFO - Running pre-action listener: _resource_record_pre_action 15:53:27 INFO - Running main action method: read_buildbot_config 15:53:27 INFO - Using buildbot properties: 15:53:27 INFO - { 15:53:27 INFO - "project": "", 15:53:27 INFO - "product": "firefox", 15:53:27 INFO - "script_repo_revision": "production", 15:53:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:53:27 INFO - "repository": "", 15:53:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:53:27 INFO - "buildid": "20160613144126", 15:53:27 INFO - "pgo_build": "False", 15:53:27 INFO - "basedir": "/builds/slave/test", 15:53:27 INFO - "buildnumber": 1855, 15:53:27 INFO - "slavename": "talos-linux64-ix-021", 15:53:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:53:27 INFO - "platform": "ubuntu64_hw", 15:53:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:53:27 INFO - "branch": "fx-team", 15:53:27 INFO - "repo_path": "integration/fx-team", 15:53:27 INFO - "revision": "cb5eccf28d080455a62d3b09f8b698c6bc306774", 15:53:27 INFO - "stage_platform": "linux64", 15:53:27 INFO - "builduid": "c420b1a61da64fa8abaca2d48d0b63c9", 15:53:27 INFO - "slavebuilddir": "test" 15:53:27 INFO - } 15:53:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:53:27 INFO - Running post-action listener: _resource_record_post_action 15:53:27 INFO - ##### 15:53:27 INFO - ##### Finished read-buildbot-config step (success) 15:53:27 INFO - ##### 15:53:27 INFO - ##### 15:53:27 INFO - ##### Running download-and-extract step. 15:53:27 INFO - ##### 15:53:27 INFO - Running pre-action listener: _resource_record_pre_action 15:53:27 INFO - Running main action method: download_and_extract 15:53:27 INFO - mkdir: /builds/slave/test/build/tests 15:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:27 INFO - https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:53:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:53:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:53:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/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 15:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/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 15:53:27 INFO - Downloaded 1361 bytes. 15:53:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:53:27 INFO - Using the following test package requirements: 15:53:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:53:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:53:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:53:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:27 INFO - u'jsshell-linux-x86_64.zip'], 15:53:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:53:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:53:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:53:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:53:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:53:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:53:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:27 INFO - https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:53:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:53:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:53:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/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 15:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/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 15:53:28 INFO - Downloaded 22651503 bytes. 15:53:28 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'] 15:53:28 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 15:53:30 INFO - Return code: 0 15:53:30 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 15:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:30 INFO - https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:53:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:53:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:53:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/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 15:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/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 15:53:33 INFO - Downloaded 22651503 bytes. 15:53:33 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'] 15:53:33 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 15:53:34 INFO - Return code: 0 15:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:34 INFO - https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/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 15:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/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 15:53:36 INFO - Downloaded 14405384 bytes. 15:53:36 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'] 15:53:36 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 15:53:36 INFO - Return code: 0 15:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:36 INFO - https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:53:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:53:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:53:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/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 15:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aH2rxKB6T9-fBODvh-Sfzg/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 15:53:38 INFO - Downloaded 55401603 bytes. 15:53:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:53:38 INFO - mkdir: /builds/slave/test/properties 15:53:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:53:38 INFO - Writing to file /builds/slave/test/properties/build_url 15:53:38 INFO - Contents: 15:53:38 INFO - build_url:https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:53:39 INFO - Running post-action listener: _resource_record_post_action 15:53:39 INFO - Running post-action listener: set_extra_try_arguments 15:53:39 INFO - ##### 15:53:39 INFO - ##### Finished download-and-extract step (success) 15:53:39 INFO - ##### 15:53:39 INFO - ##### 15:53:39 INFO - ##### Running populate-webroot step. 15:53:39 INFO - ##### 15:53:39 INFO - Running pre-action listener: _resource_record_pre_action 15:53:39 INFO - Running main action method: populate_webroot 15:53:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:53:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:53:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:53:39 INFO - '--tppagecycles', 15:53:39 INFO - '7'], 15:53:39 INFO - 'tests': ['tsvgm']}}, 15:53:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:53:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:53:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:53:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:53:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:53:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:53:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:39 INFO - 'talos_options': ['--disable-e10s'], 15:53:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:39 INFO - 'talos_options': ['--disable-e10s'], 15:53:39 INFO - 'tests': ['damp', 'tps']}, 15:53:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:39 INFO - 'tests': ['damp', 'tps']}, 15:53:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:53:39 INFO - 'tests': ['dromaeo_dom']}, 15:53:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:53:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:53:39 INFO - 'tests': ['basic_compositor_video']}, 15:53:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:53:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:53:39 INFO - 'tests': ['a11yr', 15:53:39 INFO - 'ts_paint', 15:53:39 INFO - 'tpaint', 15:53:39 INFO - 'sessionrestore', 15:53:39 INFO - 'sessionrestore_no_auto_restore', 15:53:39 INFO - 'tabpaint']}, 15:53:39 INFO - 'other-e10s': {'tests': ['a11yr', 15:53:39 INFO - 'ts_paint', 15:53:39 INFO - 'tpaint', 15:53:39 INFO - 'sessionrestore', 15:53:39 INFO - 'sessionrestore_no_auto_restore', 15:53:39 INFO - 'tabpaint']}, 15:53:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:53:39 INFO - 'ts_paint', 15:53:39 INFO - 'tpaint', 15:53:39 INFO - 'sessionrestore', 15:53:39 INFO - 'sessionrestore_no_auto_restore', 15:53:39 INFO - 'tabpaint']}, 15:53:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:53:39 INFO - 'ts_paint', 15:53:39 INFO - 'tpaint', 15:53:39 INFO - 'sessionrestore', 15:53:39 INFO - 'sessionrestore_no_auto_restore', 15:53:39 INFO - 'tabpaint']}, 15:53:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:53:39 INFO - 'tests': ['a11yr', 15:53:39 INFO - 'ts_paint', 15:53:39 INFO - 'tpaint', 15:53:39 INFO - 'sessionrestore', 15:53:39 INFO - 'sessionrestore_no_auto_restore', 15:53:39 INFO - 'tabpaint']}, 15:53:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:53:39 INFO - 'tests': ['a11yr', 15:53:39 INFO - 'ts_paint', 15:53:39 INFO - 'tpaint', 15:53:39 INFO - 'sessionrestore', 15:53:39 INFO - 'sessionrestore_no_auto_restore', 15:53:39 INFO - 'tabpaint']}, 15:53:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:53:39 INFO - 'tests': ['tsvgx', 15:53:39 INFO - 'tsvgr_opacity', 15:53:39 INFO - 'tart', 15:53:39 INFO - 'tscrollx', 15:53:39 INFO - 'cart']}, 15:53:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:53:39 INFO - 'tsvgr_opacity', 15:53:39 INFO - 'tart', 15:53:39 INFO - 'tscrollx', 15:53:39 INFO - 'cart']}, 15:53:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:39 INFO - 'talos_options': ['--disable-e10s'], 15:53:39 INFO - 'tests': ['tp5o']}, 15:53:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:39 INFO - 'tests': ['tp5o']}, 15:53:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:39 INFO - 'talos_options': ['--disable-e10s', 15:53:39 INFO - '--xperf_path', 15:53:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:39 INFO - 'tests': ['tp5n']}, 15:53:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:39 INFO - 'talos_options': ['--xperf_path', 15:53:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:39 INFO - 'tests': ['tp5n']}}, 15:53:39 INFO - 'talos.zip': {'path': '', 15:53:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:53:39 INFO - Running post-action listener: _resource_record_post_action 15:53:39 INFO - ##### 15:53:39 INFO - ##### Finished populate-webroot step (success) 15:53:39 INFO - ##### 15:53:39 INFO - ##### 15:53:39 INFO - ##### Running create-virtualenv step. 15:53:39 INFO - ##### 15:53:39 INFO - Running pre-action listener: _resource_record_pre_action 15:53:39 INFO - Running main action method: create_virtualenv 15:53:39 INFO - Creating virtualenv /builds/slave/test/build/venv 15:53:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:53:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:53:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:39 INFO - Using real prefix '/usr' 15:53:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:53:40 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:42 INFO - Installing pip.................done. 15:53:42 INFO - Return code: 0 15:53:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:42 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 0x7fe479253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:53:42 INFO - Using env: {'DISPLAY': ':0', 15:53:42 INFO - 'HOME': '/home/cltbld', 15:53:42 INFO - 'LANG': 'en_US.UTF-8', 15:53:42 INFO - 'LANGUAGE': 'en_US:en', 15:53:42 INFO - 'LOGNAME': 'cltbld', 15:53:42 INFO - 'MAIL': '/var/mail/cltbld', 15:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:42 INFO - 'MOZ_NO_REMOTE': '1', 15:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:42 INFO - 'NO_EM_RESTART': '1', 15:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:42 INFO - 'PWD': '/builds/slave/test', 15:53:42 INFO - 'SHELL': '/bin/bash', 15:53:42 INFO - 'SHLVL': '1', 15:53:42 INFO - 'TERM': 'linux', 15:53:42 INFO - 'TMOUT': '86400', 15:53:42 INFO - 'USER': 'cltbld', 15:53:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 15:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:42 INFO - '_': '/tools/buildbot/bin/python'} 15:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:53:42 INFO - Cleaning up... 15:53:42 INFO - Return code: 0 15:53:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:42 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 0x7fe479253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:53:42 INFO - Using env: {'DISPLAY': ':0', 15:53:42 INFO - 'HOME': '/home/cltbld', 15:53:42 INFO - 'LANG': 'en_US.UTF-8', 15:53:42 INFO - 'LANGUAGE': 'en_US:en', 15:53:42 INFO - 'LOGNAME': 'cltbld', 15:53:42 INFO - 'MAIL': '/var/mail/cltbld', 15:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:42 INFO - 'MOZ_NO_REMOTE': '1', 15:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:42 INFO - 'NO_EM_RESTART': '1', 15:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:42 INFO - 'PWD': '/builds/slave/test', 15:53:42 INFO - 'SHELL': '/bin/bash', 15:53:42 INFO - 'SHLVL': '1', 15:53:42 INFO - 'TERM': 'linux', 15:53:42 INFO - 'TMOUT': '86400', 15:53:42 INFO - 'USER': 'cltbld', 15:53:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 15:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:42 INFO - '_': '/tools/buildbot/bin/python'} 15:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:42 INFO - Downloading/unpacking psutil>=3.1.1 15:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:44 INFO - Installing collected packages: psutil 15:53:44 INFO - Running setup.py install for psutil 15:53:44 INFO - building 'psutil._psutil_linux' extension 15:53:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:53:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:53:44 INFO - building 'psutil._psutil_posix' extension 15:53:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:53:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:53:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:44 INFO - Successfully installed psutil 15:53:44 INFO - Cleaning up... 15:53:44 INFO - Return code: 0 15:53:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:44 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 0x7fe479253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:53:44 INFO - Using env: {'DISPLAY': ':0', 15:53:44 INFO - 'HOME': '/home/cltbld', 15:53:44 INFO - 'LANG': 'en_US.UTF-8', 15:53:44 INFO - 'LANGUAGE': 'en_US:en', 15:53:44 INFO - 'LOGNAME': 'cltbld', 15:53:44 INFO - 'MAIL': '/var/mail/cltbld', 15:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:44 INFO - 'MOZ_NO_REMOTE': '1', 15:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:44 INFO - 'NO_EM_RESTART': '1', 15:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:44 INFO - 'PWD': '/builds/slave/test', 15:53:44 INFO - 'SHELL': '/bin/bash', 15:53:44 INFO - 'SHLVL': '1', 15:53:44 INFO - 'TERM': 'linux', 15:53:44 INFO - 'TMOUT': '86400', 15:53:44 INFO - 'USER': 'cltbld', 15:53:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 15:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:44 INFO - '_': '/tools/buildbot/bin/python'} 15:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:53:47 INFO - Installing collected packages: mozsystemmonitor 15:53:47 INFO - Running setup.py install for mozsystemmonitor 15:53:47 INFO - Successfully installed mozsystemmonitor 15:53:47 INFO - Cleaning up... 15:53:47 INFO - Return code: 0 15:53:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:47 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 0x7fe479253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:53:47 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 15:53:47 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 15:53:47 INFO - Using env: {'DISPLAY': ':0', 15:53:47 INFO - 'HOME': '/home/cltbld', 15:53:47 INFO - 'LANG': 'en_US.UTF-8', 15:53:47 INFO - 'LANGUAGE': 'en_US:en', 15:53:47 INFO - 'LOGNAME': 'cltbld', 15:53:47 INFO - 'MAIL': '/var/mail/cltbld', 15:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:47 INFO - 'MOZ_NO_REMOTE': '1', 15:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:47 INFO - 'NO_EM_RESTART': '1', 15:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:47 INFO - 'PWD': '/builds/slave/test', 15:53:47 INFO - 'SHELL': '/bin/bash', 15:53:47 INFO - 'SHLVL': '1', 15:53:47 INFO - 'TERM': 'linux', 15:53:47 INFO - 'TMOUT': '86400', 15:53:47 INFO - 'USER': 'cltbld', 15:53:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 15:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:47 INFO - '_': '/tools/buildbot/bin/python'} 15:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:47 INFO - Downloading/unpacking jsonschema==2.5.1 15:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:49 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:49 INFO - warning: no files found matching '*.txt' 15:53:49 INFO - no previously-included directories found matching 'build' 15:53:49 INFO - no previously-included directories found matching 'dist' 15:53:49 INFO - no previously-included directories found matching '.git*' 15:53:49 INFO - Installing collected packages: jsonschema, functools32 15:53:49 INFO - Running setup.py install for functools32 15:53:49 INFO - warning: no files found matching '*.txt' 15:53:49 INFO - no previously-included directories found matching 'build' 15:53:49 INFO - no previously-included directories found matching 'dist' 15:53:49 INFO - no previously-included directories found matching '.git*' 15:53:49 INFO - Successfully installed jsonschema functools32 15:53:49 INFO - Cleaning up... 15:53:49 INFO - Return code: 0 15:53:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:49 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 0x7fe479253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:53:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:53:49 INFO - Using env: {'DISPLAY': ':0', 15:53:49 INFO - 'HOME': '/home/cltbld', 15:53:49 INFO - 'LANG': 'en_US.UTF-8', 15:53:49 INFO - 'LANGUAGE': 'en_US:en', 15:53:49 INFO - 'LOGNAME': 'cltbld', 15:53:49 INFO - 'MAIL': '/var/mail/cltbld', 15:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:49 INFO - 'MOZ_NO_REMOTE': '1', 15:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:49 INFO - 'NO_EM_RESTART': '1', 15:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:49 INFO - 'PWD': '/builds/slave/test', 15:53:49 INFO - 'SHELL': '/bin/bash', 15:53:49 INFO - 'SHLVL': '1', 15:53:49 INFO - 'TERM': 'linux', 15:53:49 INFO - 'TMOUT': '86400', 15:53:49 INFO - 'USER': 'cltbld', 15:53:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 15:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:49 INFO - '_': '/tools/buildbot/bin/python'} 15:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:50 INFO - Downloading/unpacking blobuploader==1.2.4 15:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:51 INFO - Downloading blobuploader-1.2.4.tar.gz 15:53:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:53:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:53:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:52 INFO - Downloading docopt-0.6.1.tar.gz 15:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:53:52 INFO - Installing collected packages: blobuploader, requests, docopt 15:53:52 INFO - Running setup.py install for blobuploader 15:53:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:53:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:53:52 INFO - Running setup.py install for requests 15:53:53 INFO - Running setup.py install for docopt 15:53:53 INFO - Successfully installed blobuploader requests docopt 15:53:53 INFO - Cleaning up... 15:53:53 INFO - Return code: 0 15:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:53 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 0x7fe479253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:53 INFO - Using env: {'DISPLAY': ':0', 15:53:53 INFO - 'HOME': '/home/cltbld', 15:53:53 INFO - 'LANG': 'en_US.UTF-8', 15:53:53 INFO - 'LANGUAGE': 'en_US:en', 15:53:53 INFO - 'LOGNAME': 'cltbld', 15:53:53 INFO - 'MAIL': '/var/mail/cltbld', 15:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:53 INFO - 'MOZ_NO_REMOTE': '1', 15:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:53 INFO - 'NO_EM_RESTART': '1', 15:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:53 INFO - 'PWD': '/builds/slave/test', 15:53:53 INFO - 'SHELL': '/bin/bash', 15:53:53 INFO - 'SHLVL': '1', 15:53:53 INFO - 'TERM': 'linux', 15:53:53 INFO - 'TMOUT': '86400', 15:53:53 INFO - 'USER': 'cltbld', 15:53:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 15:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:53 INFO - '_': '/tools/buildbot/bin/python'} 15:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:53 INFO - Running setup.py (path:/tmp/pip-hQqp44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:53 INFO - Running setup.py (path:/tmp/pip-cetsk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:53 INFO - Running setup.py (path:/tmp/pip-sd7GyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:53 INFO - Running setup.py (path:/tmp/pip-VgfN83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:53 INFO - Running setup.py (path:/tmp/pip-L6dPZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:53 INFO - Running setup.py (path:/tmp/pip-v4QNKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:53 INFO - Running setup.py (path:/tmp/pip-upBmbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:53 INFO - Running setup.py (path:/tmp/pip-M3m8iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:54 INFO - Running setup.py (path:/tmp/pip-3qgKo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:54 INFO - Running setup.py (path:/tmp/pip-oPB4KN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:54 INFO - Running setup.py (path:/tmp/pip-3kqvVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:54 INFO - Running setup.py (path:/tmp/pip-qlQDOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:54 INFO - Running setup.py (path:/tmp/pip-OPVBex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:54 INFO - Running setup.py (path:/tmp/pip-AYD8sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:54 INFO - Running setup.py (path:/tmp/pip-4vf4_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:54 INFO - Running setup.py (path:/tmp/pip-DDQiOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:54 INFO - Running setup.py (path:/tmp/pip-VwgPzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:54 INFO - Running setup.py install for manifestparser 15:53:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:53:54 INFO - Running setup.py install for mozcrash 15:53:54 INFO - Running setup.py install for mozdebug 15:53:54 INFO - Running setup.py install for mozdevice 15:53:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:53:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:53:55 INFO - Running setup.py install for mozfile 15:53:55 INFO - Running setup.py install for mozhttpd 15:53:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:53:55 INFO - Running setup.py install for mozinfo 15:53:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:53:55 INFO - Running setup.py install for mozInstall 15:53:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:53:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:53:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:53:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:53:55 INFO - Running setup.py install for mozleak 15:53:55 INFO - Running setup.py install for mozlog 15:53:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:53:55 INFO - Running setup.py install for moznetwork 15:53:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:53:55 INFO - Running setup.py install for mozprocess 15:53:55 INFO - Running setup.py install for mozprofile 15:53:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:53:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:53:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:53:56 INFO - Running setup.py install for mozrunner 15:53:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:53:56 INFO - Running setup.py install for mozscreenshot 15:53:56 INFO - Running setup.py install for moztest 15:53:56 INFO - Running setup.py install for mozversion 15:53:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:56 INFO - Cleaning up... 15:53:56 INFO - Return code: 0 15:53:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:56 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 0x7fe479253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:53:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:56 INFO - Using env: {'DISPLAY': ':0', 15:53:56 INFO - 'HOME': '/home/cltbld', 15:53:56 INFO - 'LANG': 'en_US.UTF-8', 15:53:56 INFO - 'LANGUAGE': 'en_US:en', 15:53:56 INFO - 'LOGNAME': 'cltbld', 15:53:56 INFO - 'MAIL': '/var/mail/cltbld', 15:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:56 INFO - 'MOZ_NO_REMOTE': '1', 15:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:56 INFO - 'NO_EM_RESTART': '1', 15:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:56 INFO - 'PWD': '/builds/slave/test', 15:53:56 INFO - 'SHELL': '/bin/bash', 15:53:56 INFO - 'SHLVL': '1', 15:53:56 INFO - 'TERM': 'linux', 15:53:56 INFO - 'TMOUT': '86400', 15:53:56 INFO - 'USER': 'cltbld', 15:53:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 15:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:56 INFO - '_': '/tools/buildbot/bin/python'} 15:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:56 INFO - Running setup.py (path:/tmp/pip-EjnsTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:56 INFO - Running setup.py (path:/tmp/pip-Y2CRKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:56 INFO - Running setup.py (path:/tmp/pip-ehqt57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:56 INFO - Running setup.py (path:/tmp/pip-Cg8G8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:56 INFO - Running setup.py (path:/tmp/pip-Vn_Jp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:57 INFO - Running setup.py (path:/tmp/pip-HRsr78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:57 INFO - Running setup.py (path:/tmp/pip-NK4RJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:57 INFO - Running setup.py (path:/tmp/pip-UWieXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:57 INFO - Running setup.py (path:/tmp/pip-1sZY0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:57 INFO - Running setup.py (path:/tmp/pip-0CA029-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:57 INFO - Running setup.py (path:/tmp/pip-Dpx3C4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:57 INFO - Running setup.py (path:/tmp/pip-S8JQLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:57 INFO - Running setup.py (path:/tmp/pip-xRX4YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:57 INFO - Running setup.py (path:/tmp/pip-2H8mYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:57 INFO - Running setup.py (path:/tmp/pip-Rdo5rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:57 INFO - Running setup.py (path:/tmp/pip-guAFFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:57 INFO - Running setup.py (path:/tmp/pip-vN9o5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:53:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53: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 15:53: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 15:53: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 15:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53: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 15:53: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 15:53:59 INFO - Downloading blessings-1.6.tar.gz 15:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:59 INFO - Installing collected packages: blessings 15:53:59 INFO - Running setup.py install for blessings 15:53:59 INFO - Successfully installed blessings 15:53:59 INFO - Cleaning up... 15:54:00 INFO - Return code: 0 15:54:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:00 INFO - Reading from file tmpfile_stdout 15:54:00 INFO - Current package versions: 15:54:00 INFO - argparse == 1.2.1 15:54:00 INFO - blessings == 1.6 15:54:00 INFO - blobuploader == 1.2.4 15:54:00 INFO - docopt == 0.6.1 15:54:00 INFO - functools32 == 3.2.3-2 15:54:00 INFO - jsonschema == 2.5.1 15:54:00 INFO - manifestparser == 1.1 15:54:00 INFO - mozInstall == 1.12 15:54:00 INFO - mozcrash == 0.17 15:54:00 INFO - mozdebug == 0.1 15:54:00 INFO - mozdevice == 0.48 15:54:00 INFO - mozfile == 1.2 15:54:00 INFO - mozhttpd == 0.7 15:54:00 INFO - mozinfo == 0.9 15:54:00 INFO - mozleak == 0.1 15:54:00 INFO - mozlog == 3.2 15:54:00 INFO - moznetwork == 0.27 15:54:00 INFO - mozprocess == 0.22 15:54:00 INFO - mozprofile == 0.28 15:54:00 INFO - mozrunner == 6.11 15:54:00 INFO - mozscreenshot == 0.1 15:54:00 INFO - mozsystemmonitor == 0.3 15:54:00 INFO - moztest == 0.7 15:54:00 INFO - mozversion == 1.4 15:54:00 INFO - psutil == 3.1.1 15:54:00 INFO - requests == 1.2.3 15:54:00 INFO - wsgiref == 0.1.2 15:54:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:00 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 0x7fe479253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:54:00 INFO - Using env: {'DISPLAY': ':0', 15:54:00 INFO - 'HOME': '/home/cltbld', 15:54:00 INFO - 'LANG': 'en_US.UTF-8', 15:54:00 INFO - 'LANGUAGE': 'en_US:en', 15:54:00 INFO - 'LOGNAME': 'cltbld', 15:54:00 INFO - 'MAIL': '/var/mail/cltbld', 15:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:00 INFO - 'MOZ_NO_REMOTE': '1', 15:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:00 INFO - 'NO_EM_RESTART': '1', 15:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:00 INFO - 'PWD': '/builds/slave/test', 15:54:00 INFO - 'SHELL': '/bin/bash', 15:54:00 INFO - 'SHLVL': '1', 15:54:00 INFO - 'TERM': 'linux', 15:54:00 INFO - 'TMOUT': '86400', 15:54:00 INFO - 'USER': 'cltbld', 15:54:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 15:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:00 INFO - '_': '/tools/buildbot/bin/python'} 15:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:54:00 INFO - Cleaning up... 15:54:00 INFO - Return code: 0 15:54:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe479253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:54: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', 'jsonschema'] in /builds/slave/test/build 15:54: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 jsonschema 15:54:00 INFO - Using env: {'DISPLAY': ':0', 15:54:00 INFO - 'HOME': '/home/cltbld', 15:54:00 INFO - 'LANG': 'en_US.UTF-8', 15:54:00 INFO - 'LANGUAGE': 'en_US:en', 15:54:00 INFO - 'LOGNAME': 'cltbld', 15:54:00 INFO - 'MAIL': '/var/mail/cltbld', 15:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:00 INFO - 'MOZ_NO_REMOTE': '1', 15:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:00 INFO - 'NO_EM_RESTART': '1', 15:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:00 INFO - 'PWD': '/builds/slave/test', 15:54:00 INFO - 'SHELL': '/bin/bash', 15:54:00 INFO - 'SHLVL': '1', 15:54:00 INFO - 'TERM': 'linux', 15:54:00 INFO - 'TMOUT': '86400', 15:54:00 INFO - 'USER': 'cltbld', 15:54:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 15:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:00 INFO - '_': '/tools/buildbot/bin/python'} 15:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:54:00 INFO - Cleaning up... 15:54:00 INFO - Return code: 0 15:54:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe479253f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a51350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, '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': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:54: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', 'flake8'] in /builds/slave/test/build 15:54: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 flake8 15:54:00 INFO - Using env: {'DISPLAY': ':0', 15:54:00 INFO - 'HOME': '/home/cltbld', 15:54:00 INFO - 'LANG': 'en_US.UTF-8', 15:54:00 INFO - 'LANGUAGE': 'en_US:en', 15:54:00 INFO - 'LOGNAME': 'cltbld', 15:54:00 INFO - 'MAIL': '/var/mail/cltbld', 15:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:00 INFO - 'MOZ_NO_REMOTE': '1', 15:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:00 INFO - 'NO_EM_RESTART': '1', 15:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:00 INFO - 'PWD': '/builds/slave/test', 15:54:00 INFO - 'SHELL': '/bin/bash', 15:54:00 INFO - 'SHLVL': '1', 15:54:00 INFO - 'TERM': 'linux', 15:54:00 INFO - 'TMOUT': '86400', 15:54:00 INFO - 'USER': 'cltbld', 15:54:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 15:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:00 INFO - '_': '/tools/buildbot/bin/python'} 15:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:00 INFO - Downloading/unpacking flake8 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:54:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:54:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:54:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:54:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:54:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:54:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:54:03 INFO - no previously-included directories found matching 'docs/_build' 15:54:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:54:03 INFO - Running setup.py install for pep8 15:54:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:54:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:54:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:54:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:54:03 INFO - no previously-included directories found matching 'docs/_build' 15:54:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:54:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:54:03 INFO - Cleaning up... 15:54:03 INFO - Return code: 0 15:54:03 INFO - Running post-action listener: _resource_record_post_action 15:54:03 INFO - Running post-action listener: _start_resource_monitoring 15:54:03 INFO - Starting resource monitoring. 15:54:03 INFO - ##### 15:54:03 INFO - ##### Finished create-virtualenv step (success) 15:54:03 INFO - ##### 15:54:03 INFO - ##### 15:54:03 INFO - ##### Running install step. 15:54:03 INFO - ##### 15:54:03 INFO - Running pre-action listener: _resource_record_pre_action 15:54:03 INFO - Running main action method: install 15:54:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:03 INFO - Reading from file tmpfile_stdout 15:54:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:54:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:54:04 INFO - Reading from file tmpfile_stdout 15:54:04 INFO - Output received: 15:54:04 INFO - Usage: mozinstall [options] installer 15:54:04 INFO - Options: 15:54:04 INFO - -h, --help show this help message and exit 15:54:04 INFO - -d DEST, --destination=DEST 15:54:04 INFO - Directory to install application into. [default: 15:54:04 INFO - "/builds/slave/test"] 15:54:04 INFO - --app=APP Application being installed. [default: firefox] 15:54:04 INFO - mkdir: /builds/slave/test/build/application 15:54:04 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'] 15:54:04 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 15:54:21 INFO - Reading from file tmpfile_stdout 15:54:21 INFO - Output received: 15:54:21 INFO - /builds/slave/test/build/application/firefox/firefox 15:54:21 INFO - Running post-action listener: _resource_record_post_action 15:54:21 INFO - ##### 15:54:21 INFO - ##### Finished install step (success) 15:54:21 INFO - ##### 15:54:21 INFO - ##### 15:54:21 INFO - ##### Running run-tests step. 15:54:21 INFO - ##### 15:54:21 INFO - Running pre-action listener: _resource_record_pre_action 15:54:21 INFO - Running main action method: run_tests 15:54:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:54:21 INFO - Python 2.7.3 15:54:21 INFO - Return code: 0 15:54:21 INFO - grabbing minidump binary from tooltool 15:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:21 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 0x2ae01c0>, '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 0x2ae10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:54:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:54:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:54:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:54:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:54:21 INFO - Return code: 0 15:54:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:54:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:54:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:54:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:54:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:54:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:54:22 INFO - Return code: 0 15:54:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:54:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:54:22 INFO - Using env: {'DISPLAY': ':0', 15:54:22 INFO - 'HOME': '/home/cltbld', 15:54:22 INFO - 'LANG': 'en_US.UTF-8', 15:54:22 INFO - 'LANGUAGE': 'en_US:en', 15:54:22 INFO - 'LOGNAME': 'cltbld', 15:54:22 INFO - 'MAIL': '/var/mail/cltbld', 15:54:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:22 INFO - 'MOZ_NO_REMOTE': '1', 15:54:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:22 INFO - 'NO_EM_RESTART': '1', 15:54:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:22 INFO - 'PWD': '/builds/slave/test', 15:54:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:22 INFO - 'SHELL': '/bin/bash', 15:54:22 INFO - 'SHLVL': '1', 15:54:22 INFO - 'TERM': 'linux', 15:54:22 INFO - 'TMOUT': '86400', 15:54:22 INFO - 'USER': 'cltbld', 15:54:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465858162.530165-834287790', 15:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:22 INFO - '_': '/tools/buildbot/bin/python'} 15:54:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:54:22 INFO - mozversion application_buildid: 20160613144126 15:54:22 INFO - mozversion application_changeset: cb5eccf28d080455a62d3b09f8b698c6bc306774 15:54:22 INFO - mozversion application_display_name: Nightly 15:54:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:54:22 INFO - mozversion application_name: Firefox 15:54:22 INFO - mozversion application_remotingname: firefox 15:54:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:54:22 INFO - mozversion application_vendor: Mozilla 15:54:22 INFO - mozversion application_version: 50.0a1 15:54:22 INFO - mozversion platform_buildid: 20160613144126 15:54:22 INFO - mozversion platform_changeset: cb5eccf28d080455a62d3b09f8b698c6bc306774 15:54:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:54:22 INFO - mozversion platform_version: 50.0a1 15:54:22 INFO - using testdate: 1465858462 15:54:22 INFO - actual date: 1465858462 15:54:22 INFO - starting webserver on 'localhost:33423' 15:54:22 INFO - SUITE-START | Running 2 tests 15:54:22 INFO - TEST-START | dromaeo_css 15:54:22 INFO - operating with platform_type : linux_ 15:54:22 INFO - Initialising browser for dromaeo_css test... 15:54:22 INFO - TEST-INFO | started process 8386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu8AjKD/profile http://localhost:33423/getInfo.html) 15:54:27 INFO - PROCESS | 8386 | __metrics Screen width/height:1600/1200 15:54:27 INFO - PROCESS | 8386 | colorDepth:24 15:54:27 INFO - PROCESS | 8386 | Browser inner width/height: 1024/697 15:54:27 INFO - PROCESS | 8386 | __metrics 15:54:29 INFO - PROCESS | 8386 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:54:29 INFO - PROCESS | 8386 | console.error: PushService: 15:54:29 INFO - PROCESS | 8386 | stateChangeProcessEnqueue: Error transitioning state 15:54:29 INFO - PROCESS | 8386 | UnknownError 15:54:30 INFO - TEST-INFO | 8386: exit 0 15:54:30 INFO - Browser initialized. 15:54:30 INFO - Running cycle 1/1 for dromaeo_css test... 15:54:30 INFO - TEST-INFO | started process 8468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu8AjKD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:42 INFO - PROCESS | 8468 | RSS: Main: 178679808 15:54:42 INFO - PROCESS | 8468 | 15:55:33 INFO - PROCESS | 8468 | 1465858533621 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:57:46 INFO - PROCESS | 8468 | Cycle 1(1): loaded http://localhost:33423/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33423/tests/dromaeo/cssquery-ext.html) 15:57:47 INFO - PROCESS | 8468 | RSS: Main: 259796992 15:57:47 INFO - PROCESS | 8468 | 16:00:50 INFO - PROCESS | 8468 | Cycle 1(1): loaded http://localhost:33423/tests/dromaeo/cssquery-ext.html (next: http://localhost:33423/tests/dromaeo/cssquery-jquery.html) 16:00:51 INFO - PROCESS | 8468 | RSS: Main: 262311936 16:00:51 INFO - PROCESS | 8468 | 16:03:53 INFO - PROCESS | 8468 | Cycle 1(1): loaded http://localhost:33423/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33423/tests/dromaeo/cssquery-mootools.html) 16:03:54 INFO - PROCESS | 8468 | RSS: Main: 260096000 16:03:54 INFO - PROCESS | 8468 | 16:06:56 INFO - PROCESS | 8468 | Cycle 1(1): loaded http://localhost:33423/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33423/tests/dromaeo/cssquery-prototype.html) 16:06:56 INFO - PROCESS | 8468 | RSS: Main: 254480384 16:06:56 INFO - PROCESS | 8468 | 16:09:59 INFO - PROCESS | 8468 | Cycle 1(1): loaded http://localhost:33423/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33423/tests/dromaeo/cssquery-yui.html) 16:10:00 INFO - PROCESS | 8468 | RSS: Main: 243437568 16:10:00 INFO - PROCESS | 8468 | 16:13:03 INFO - PROCESS | 8468 | Cycle 1(1): loaded http://localhost:33423/tests/dromaeo/cssquery-yui.html (next: http://localhost:33423/tests/dromaeo/cssquery-dojo.html) 16:13:03 INFO - PROCESS | 8468 | RSS: Main: 295731200 16:13:03 INFO - PROCESS | 8468 | 16:13:03 INFO - PROCESS | 8468 | __start_tp_report 16:13:03 INFO - PROCESS | 8468 | _x_x_mozilla_page_load 16:13:03 INFO - PROCESS | 8468 | _x_x_mozilla_page_load_details 16:13:03 INFO - PROCESS | 8468 | |i|pagename|runs| 16:13:03 INFO - PROCESS | 8468 | |0;dojo.html;2574.755398237167;2607.3611965068553;2622.3837398211417;2625.671791026122;2657.3622330640646;4639.744814035227;4737.1946769049255;4738.668293219476;4804.927926081107;4827.806887724491;4784.712917224969;4828;4837.201861692816;4843.225083986563;4849.248366503189;4396.494403143647;4425.336199570058;4464.553544645542;4528.04910968697;4632.907341853161;4579.610733087691;4589.196890544158;4600.378948841913;4613.077384523092;4635.049814787961;4330.740155590659;4363.498197707273;4379.43067401239;4403.977980110111;4429.557044295577;4380.189664912002;4381.9342709859375;4392.626626736699;4449.7330160190495;4475.216837053503;4404.163208990313;4418.734875907424;4426.867193984185;4468.419105516295;4471.8658440246845;4716.363290955712;4830.29960655703;4882.609391248691;4887.340209071801;4904.411470623512;5254.448282930313;5273.841784746425;5307.442718514539;5330.653507522037;5335.279737235463;5328.254044433782;5367.194920761878;5367.838964831022;5369.892602147975;5372.892542149135;4711.222648263032;4736.052789442126;4782.33047373368;4786.994731106437;4809.95190048102;5271.4728527147745;5306.814261500829;5307.6284660073425;5309.256704061435;5309.734513274321;4950.158473059589;5085.415177254663;5091.770870310845;5104.9744751276;5106.259592359087;5082.263071854561;5118.462561431071;5124.897502050013;5127.743612819344;5149.897002060013;5092.185250359925;5101.69592619837;5101.719405432663;5106.438291787975;5161.948380516222;4948.331975183376;5076;5089.567386772092;5092.0579692756955;5104.668196567211;4391.3193455014525;4401.207782599163;4419.292913133948;4459.375687403766;4463.977680111579;3841.3469710149343;3852.5184351956004;3863.285292220948;3868.9806550967064;3899.902502437405;4278.657707383401;4318.762468064287;4449.110177964355;4481.417415735934;4496.437945256843;5149.45930677281;5167.819126330561;5214.2960700304975;5218.399884013387;5232.502912223333;4400.471943366816;4401.691881568324;4409.801558929856;4447.866564003085;4456.3538286948215;4573.199690054294;4625.213713668684;4657.883552911204;4677.438707355139;4706.694064885772;4838;4856.295837103529;4858.562729354375;4886.218205087312;4900.387451568483;5161.432242453252;5175.171972484384;5182.740862956762;5190.195519694454;5193.42872284056;4712.410948631421;4897.36334276556;4899.510048995072;4932.4327702314695;4955.876103097451;5194.766235519335;5207.297014903091;5210.869728256824;5212.322398088376;5216.9739151304;5292.20616907467;5296.708681022581;5296.894062118659;5307.575393968396;5338.386085600206;4866.489018653132;4957.206846904478;4966.081274964144;4999.200127979506;5032.723200224023;4995.300657907823;5016.724080175625;5024.070546948826;5028.321176641253;5075.3402057732255;4836.492168322417;4942.8764280893265;4956.578690811177;4997.400311962588;5001.824936127364;4948.727819969936;4970.055689419143;4984.950150498448;4991.650584459053;5011.774470148779;4902.779374928065;4912.901741965069;4914.189158788903;4917.188663870565;4971.776270067928 16:13:03 INFO - PROCESS | 8468 | |1;ext.html;581.8603535151562;593.4303069053708;593.8604427959428;594.6640148316201;595.559286128265;38499.615003849955;40270.39594406082;40357.79821100894;43574.12851742971;43605;41483;41954.16091678172;41962.790186049104;42002;42014.579854201445;7628.389728821681;7906.604669766518;8054.798630034237;8060.476069055522;10110.241731870103;9905.900940990607;10295.279330446872;10299.227557933147;10300.845487317696;10304.433256170907;10291.742706432324;10324.432156231442;10337.741556461073;10349.689509314732;10358.223133264997;7677.577733224698;9979.10188083076;10311.123554497877;10312.381257124522;10317.484125793755;10260.076593106582;10343.120834729058;10345.741356466073;10347.327423717434;10353;39211.8039409804;39384.212315753524;39572;39624;39709.80145099285;3204.5033019881957;3302.207470207133;3398.8130652814084;3417.2311229973056;3551.485034669958;29735.107946761633;29776.553351699742;29943.70056299431;29963.700362996307;31081.067567972997;3530.9293814123575;3547.7050876430176;3550.8934731958084;3566.82681262923;3607.549056367954;249285.9999999982;249369;249987;250099;250718;51691;51745;52053;52082.21876671853;52623.21065184025;32955;33892.15269618279;54223;54619;54847.45152548423;14514.419423222953;14631.707365852624;14645.414183432757;14659.267036648338;14660.340284687001;9030.86453703195;10679.199060070527;10811.891881081247;10923.563057477611;11063.668089957315;18326;18403.631927361646;18405.355812546495;18442;18449.446516604523;6878.415334696507;7066.893996590055;7086.751963681247;7093.219745827955;7099;910.544727636182;915.5971372596036;938.3056538161848;950.5057370167474;1041.6770801051698;28389;28407.43185136327;28951.276218094717;29341.119766407042;29385.265368365534;967.3567077893263;1032.1897310611134;1040.7710303733168;1044.3420644993757;1061.0556604621893;14820.70358592822;15333.6166595836;15338.386464541516;15493.535193944199;15562.688746225012;370314;373185;374086;374207;375153;49127;49540.50459495431;49564;49620.25569616459;49705;1085.913126949842;1116.3134672176716;1186.665001872893;1216.2398500936915;1217.7686239614623;26640.866795665897;29060.854695726386;29295.707042929298;29535.704642954155;29666.258343541584;41374.58625413707;41602.58397416108;42016.369754453095;42025.579744202165;42047.57952420559;285263;288255;288773;290115;290207;22247.66628500606;24547.38631534226;25404;25482.872585636953;25625.92488901269;41632.375514367915;42004.78997604993;42495.5750442504;42528.362074568286;42924.57075429331;35835;36033.81983090068;36747.63252367549;36890;37158.44262336121;35696.28607427889;36339.81830090833;36433.81783091067;36532.616086069844;36553.63446365502;35162;35678.10804729799;36282;36434.27131457409;36442.45336319904;30202.69797301999;32291;33003.504947426285;33073;33181.17047073843;24539.38651533726;24574.754252457245;24970.250892473254;25348.239552813444;25357 16:13:03 INFO - PROCESS | 8468 | |2;jquery.html;375.6243756243756;378.60814057450534;383.13411689581574;385.9266739319531;396.928552860485;16023.439179628715;16354.83645163548;17129.057901815395;17270.2228399722;17291.394801181945;15771.763423548657;16565.503034908943;16589.087600181985;16626.75059874103;17305.91347043266;3514.1390359361994;4647.7676116194225;4848.539388758062;4850.199717046683;4851.733154676492;3618.6019537850816;5248.895022099575;5474.589405794562;5480.862978425552;5608.074667679828;5255.894882102356;5587.441255874421;5588.105903055512;5594.9720251398685;5603.439656034405;3465.1337165708574;5483.122700367922;5607.046802043622;5633.267675202238;5638.069718496443;5039.84880453587;5305;5313.548348390392;5412.025835349636;5426.457354264581;11205.887941120565;11316.151288653384;11607.245529040585;12583.182093163916;12982.545610903573;1775.9556011099696;1935.8064193580528;1971.1327016112864;1981.782003979561;2071.927482538104;9281;9904.55429505674;9937.65218217359;10890.292131011538;13551.322433878267;1779.7597324361175;1968.881867087965;1974.8123928226796;2082.6771850363216;2084.8957552122333;59736.40263597395;61052.38947610511;61843.07235391518;70039.64980175118;82989;14764.63088422798;15656.954370533305;16178.919105404397;16246.918765406097;16515.256813443422;29083.27291817679;29281.707182928323;29648.407031859242;29696.851515742284;29750.25624359365;8573.528455934858;8890.511021893728;8904.910950890539;8985.236254918274;9247;7370.520916140434;7379.188289288174;7477.70089196426;7504.887426688604;7506.573750987295;7919.990403646692;8295.543745093957;8355.874661880076;8492.872606910902;8678.56607169639;2640;3262.151840521434;3277.3609146216736;3365.8148801815646;3507.649235076472;780.6252998560723;862.3963225742006;928.9628414863465;957.3250858144991;964.3297907953905;15942;16932.746008809878;17632.20655070525;17815.376461823773;18576.164072616764;848.4909054567333;855.3371137368465;867.2065060469599;882.373514804496;931.7624005878594;9372.343935924557;9407.811843763086;9740.46427446483;9814.362066465657;9961.850572241423;176256;179786;179932;410947;432447;78195.60902195566;80180;82349;82627;84277;942.2791564453199;952.5380190607411;980.1472718734747;982.0964712464549;983.4050399508337;15368;15651.530454086396;15792.76310855315;16104.516864494084;16141.75787363214;34712.9586112417;36619;37121.07197320089;37430.812845936685;38081.42877856779;49128.75435622799;53851.19223211733;53918.19122713084;53921.46078539321;54099.67202623859;7468.813279668052;7570.129435115033;7602.7339043133225;7652.464327497022;7705.1524332324525;7888.802779930547;10541.78916421652;11206.38364889939;11232.494537745657;11239.157063220127;9728.854067188857;9877.901220987698;9888;9897.604095836374;10063.245256605931;10141.594336226763;10195.84706229422;10250.942273358341;10315.17478601725;10329.431881246604;9025.187733104052;9576.90423095788;9800.558974846292;9838.26213034011;9984.301098923006;7190.604516751419;7325.230850760593;7378.520396174232;7404.96297518509;7479.70081196746;8014.398920080901;8312.33501319905;8423.452475589067;9122.27021838238;9248.537573121452 16:13:03 INFO - PROCESS | 8468 | |3;mootools.html;1370.0615078671105;1384.9653758656032;1423.9288035598217;1508.9245537723111;1703.2904020383633;6961.477889158315;7727.265909738573;7963.362930965523;7979.441439099265;8132.634031468583;8043.839123217532;8051.154628763983;8119.756407307776;8119.9188008120045;8133.877991830127;2263.0721404224314;2289.896954637037;2293.4266433391654;2294.908203671851;2296.540691861626;2187.6718492226214;2190.5728382965326;2213.6236839737285;2223.6442169252923;2227.1982086448947;2224.477247846755;2233.7877901599322;2241.8991145398413;2246.472079061419;2255.9210427635035;2128.265748316828;2146.602878467481;2147.3021268087778;2153.5477549714656;2153.6338822400153;2168.4687251623454;2175.380016695234;2204.1624182810588;2205.7022301989346;2205.922792702264;7911.920880791176;7985.2014798519685;8043.919560804434;8048.195180481964;8053.154418786002;4552.089582083597;4727.550882666142;4733.905321893543;4736.100140973204;4741.952580474185;2819.4643017826547;2911.883524659011;2954.6011288475997;2965.648816836982;2975.1074677596635;871.6818361298144;872.8559787635032;879.5470332778624;880.5861245214738;880.7049638371153;10971.780564388668;11049.779004419946;11093.445327733582;11095.667129986032;11100.444977751162;4168.6665066794585;4256.3189889617515;4309.224339618899;4311.8706438806885;4340.023494713727;8772.868406973901;8780.956095219482;8815.118488151134;8831.470111793184;8838;4718.811247550059;4728.668993170514;4763.95236047642;4768.523147685204;4773.427188737373;3850.5186851643543;4255.5744425557195;4341.934870976938;4405.84579539721;4428.512863585003;3403.7617366784584;3410.3861304965344;3497.4753786931656;3538.062413460435;3574.857005719794;1046.6179844356907;1050.2963014780116;1054.9419781912068;1060.3319908457622;1062.293574772783;695.0616667498836;705.3264132753209;824.9175082491703;843.6330196364601;854.9871751923727;5189.117849965515;5231.738413079407;5293.232481290192;5301.390340110936;5387.461253874581;425.9850905218303;427.37389724054407;429.0132694802005;451.1630924634821;600.7114738885067;3371.443711787577;3559.1635965548076;3587.3901436755814;3599.6940260077663;3605.170810713498;9788.168005719452;10039.849402258971;10137.949310253549;10192.980701929897;10205.591776329013;10081.143102836195;10096.848547271797;10108.140808031252;10120.392776433437;10153.39079655223;7280.089988751406;7538.811529711801;7548.094228692592;7561.621918904033;7576.7348142814735;5200.713960732196;5234.816781412632;5316.494932981361;5413.56691464674;5532.446755324436;8764.91235087641;9104.089591040844;9117.635294588143;9238.907610923805;9405.05949405054;9147.451152930846;9343.205827504738;9357.906420935704;9359.67241146584;9375.718728438158;6887.2079710831895;7008.22909479967;7050.682719277747;7060.71757129709;7065.894011589933;7347.926520734938;7491.812704682427;7548.924510755041;7554.206808285271;7564.130125035691;7035.648217589202;7091.184513780981;7119.857602848017;7266.309700578437;7348.485606007528;6982.546134501241;7082.291770822876;7100.822479438056;7174.533655312388;7212.71149154028;6597.208334999831;6605.207375115017;6638.867222655616;6643.368879956396;6675.23234828001;4417.668674849463;4614.515475874985;4665.04366604852;4680.321353403806;4685.203515402458;4737.28940658904;4741.122892264942;4744.644151688706;4763.404574428197;4786.042791441795 16:13:03 INFO - PROCESS | 8468 | |4;prototype.html;278.2348541510844;295.47700569991116;300.7218323051177;301.2754325846339;309.4769838972137;4762.095161935227;4883.926741098886;4911.165101932671;4948.109340318746;4957.380327459072;4669.276262179367;4788.592969597588;4795.520447955203;4839.741667166536;4862.7325497097645;3824.063104539378;3833.290841194374;3843.8078096095223;3861.4014827701612;3873.128546077124;3618;3692.9076773080756;3816.160444702161;3820.675242604368;3827.9043023924487;3749.343864823645;3769.18962423079;3788.109794198361;3808.21931504041;3809.4857194278834;3759.398496240602;3759.793211373373;3762.2287431076566;3763.07804587875;3779.622037796226;3318.5188147718445;3325.068980685412;3337.2991671748964;3338.2322065924973;3345.6152542457444;4637.489876113625;4707.058588282357;4749.667523273372;4759.738214398207;4784.497627749071;4339.457567804025;4348.260795664744;4357.193919124972;4361.978190109061;4368.716033457815;5100.438951715309;5134.332536770196;5141.614378921596;5143.459936706629;5145.30538377318;3562.928741425183;3648.1973965727498;3658.963410365889;3671.3208056509366;3672.889813305605;5274.235235890813;5321.3348331458565;5321.654092484015;5325.4940780625775;5336.67979921206;3715.684166845794;3718.9814050930113;3733.5893051764283;3734.589195188527;3748.2690875279604;3681.7238707097076;3724.8557326692553;3755.511783468132;3758.473813666089;3773.4905787718853;4315.4605674290715;4323.740575565414;4332.631726303236;4337.869863904025;4339.674524410681;5105.617078719111;5107.489251074863;5107.668001579886;5120.897582048338;5136;1255.7049093463029;1300.3498250874563;1327.8074679171466;1336.1648969394128;1338.8527262001367;850.9489430634181;863.451708165307;873.366809063424;873.9169778870997;876.7282142535835;3930.21395720857;3994.201159768058;4001.299772539794;4017.5379831319774;4018.1963607278662;4595.357669340143;4599.953020905665;4630.536946305342;4638.397008388955;4673.060679817838;3906.277338692294;4010.9598904010586;4011.1777085697363;4024.557298697141;4028.6906755304644;2268.00226800225;2433.2213691618867;2463.300322777278;2491.601343785022;2505.6993160820816;4318.935215971763;4366.580861220116;4369;4385.934210986838;4393.857597024797;4683;4744.299446431789;4755.881102972384;4772.76136193189;4789.928151077736;4092.5444733159866;4390.924223565247;4391.912161756747;4405.559444055569;4434.534373890695;4592.242280023758;4592.816287348603;4596.770161491845;4639.930401044055;4667.32323813052;4592.048379438658;4603.424571928509;4612.310151878551;4621.537846215351;4643.628509719147;4103.692223083341;4287.970886987163;4298.667413101948;4307.267764479983;4383.912321753611;3469.9653003470653;3484.494748261437;3500.8097246936163;3513.5945621751503;3526.18897653536;4639.32729754177;4667.229907065296;4678.883027924329;4715.740634265148;5082.745862706776;4971.776270067783;5099.495648783543;5141.820036298712;5152.6650767699975;5157.510036546522;5113.079645663816;5113.696007518059;5113.8977220454635;5120.795168193231;5123.948760512347;4827.42070951488;5010.148274793221;5010.8246211383885;5042.319286896369;5052.242163675478;5063.5695965843315;5106.412762532208;5118.744062796771;5135.690398948244;5153.175491921274;5014.671112155354;5023.146065169003;5041.395032596112;5044.949550504448;5061.9493805061475 16:13:03 INFO - PROCESS | 8468 | |5;yui.html;667.2593421302354;682.5290549520834;705.3933617089302;717.6949796336555;773.8877862709905;12066.457009434575;12276.5703200388;12328.81506777398;13332;13764.862351376483;11643.35961522116;11760.411979401038;11789.469473873674;11860.881391186085;11931.105167112459;626.6271568416807;765.4029856711774;790.8260182759784;809.4495742894829;815.4903185509057;796.8685166947475;810.4569938141459;810.8580998325299;810.8621534339177;810.8824220488026;853.4282031039219;856.6530555125184;856.9571521423935;857.1856736100698;857.1985193843744;648.9772857949949;813.0812182234097;838.4005436113208;850.740524140137;851.6678495386805;615.5814046448413;616.1743264026227;616.2389449030444;616.7193926763312;616.9973792587047;12073.275603463733;12098;12169.026477881749;12196.207246528948;12207.206531575508;12278.570250041206;12740.681482962907;12741.681457963532;12810.267345576296;13024.283664398454;11367.602133925355;11369.772604547863;11663.183577149603;11666.824997624957;12087.21433106854;4002.199560087994;4003.099302656908;4079.8368065277355;4183.853565125237;4187.1625674865145;59831.401685983015;60378;60655.69672151655;60796.78406431847;60959.695201524155;9797.80404391908;10276.691699249035;10304.948475257575;10395.94802025985;10559.683209503728;15998.200089995453;16183.919080404523;16222.83777162237;16225.756613650805;16239.59401014984;6534.215894092739;6562.278149403562;6583.9012414813815;6868.828279292958;7017.3684368407085;3665.138692407282;3704.407294832814;3707.94438083429;3763.2097259575794;3795.9430608540893;2915.1400336900665;2999.100269919059;3004.1888690053565;3005.383896301253;3005.594244776927;548.958828087887;580.8634970781862;585.1924344404695;589.3693747689931;597.333972620525;554.692145859044;560.3751816724323;565.7397597105295;570.7003822992879;577.8270111673226;7395.963020184972;7414.221506741822;7592.354649854714;7693.576853273012;7985.560794156261;555.849920521465;566.4646908671266;574.3968832725621;578.4967078641524;585.748128304833;3748.7188460865545;3755.4179102239195;3792.943105853414;3904.902377440587;3916.6475017248586;94807.52596236975;99557;99671.50164249132;100603;101840.49079754703;89502;89666;91384.5430772842;91652.54173729089;92707;78125.60937195392;78265.60867195627;79447.20552794513;79902.6004869972;80008.59995699984;7316.268373162641;7343.70625174987;7521.7743467696055;7577.810554736176;7698.769036928677;45308;46082.76958615185;46433.76783116063;46921.296180558005;46953.2957005652;55023.72488137534;67590;67785;68434.65782671055;68509.3149068503;8823.470591764259;8832.823343533222;8850.291976641724;8934.955325223333;9269.30480214;10868.478413022342;10922.945385273022;10944.343339399662;11071.612493562687;11072.39101849406;10027.949860250652;10072.194224461879;10168.440735759605;10172.643957461454;10175.949120254352;10063.798724025624;10128.493575321352;10425.843612345972;10463.424511651629;10637.840432393676;9506.334556581249;9537.761555960878;9736.821149864774;9975.401475911469;10175.592976280866;7919.208079192034;8106.432549721463;8426.915730842613;8541.829163416573;8655.783605409915;8553.82892342162;8800.647974080965;8844.867326990228;8879;8969.638919652483 16:13:03 INFO - PROCESS | 8468 | __end_tp_report 16:13:03 INFO - PROCESS | 8468 | __start_cc_report 16:13:03 INFO - PROCESS | 8468 | _x_x_mozilla_cycle_collect,964 16:13:03 INFO - PROCESS | 8468 | __end_cc_report 16:13:03 INFO - PROCESS | 8468 | __startTimestamp1465859583375__endTimestamp 16:13:03 INFO - PROCESS | 8468 | 16:13:03 INFO - PROCESS | 8468 | ------- Summary: start ------- 16:13:03 INFO - PROCESS | 8468 | Number of tests: 6 16:13:03 INFO - PROCESS | 8468 | 16:13:03 INFO - PROCESS | 8468 | [#0] dojo.html Cycles:165 Average:4779.14 Median:4899.51 stddev:517.45 (10.6%) stddev-sans-first:489.29 16:13:03 INFO - PROCESS | 8468 | Values: 2574.8 2607.4 2622.4 2625.7 2657.4 4639.7 4737.2 4738.7 4804.9 4827.8 4784.7 4828.0 4837.2 4843.2 4849.2 4396.5 4425.3 4464.6 4528.0 4632.9 4579.6 4589.2 4600.4 4613.1 4635.0 4330.7 4363.5 4379.4 4404.0 4429.6 4380.2 4381.9 4392.6 4449.7 4475.2 4404.2 4418.7 4426.9 4468.4 4471.9 4716.4 4830.3 4882.6 4887.3 4904.4 5254.4 5273.8 5307.4 5330.7 5335.3 5328.3 5367.2 5367.8 5369.9 5372.9 4711.2 4736.1 4782.3 4787.0 4810.0 5271.5 5306.8 5307.6 5309.3 5309.7 4950.2 5085.4 5091.8 5105.0 5106.3 5082.3 5118.5 5124.9 5127.7 5149.9 5092.2 5101.7 5101.7 5106.4 5161.9 4948.3 5076.0 5089.6 5092.1 5104.7 4391.3 4401.2 4419.3 4459.4 4464.0 3841.3 3852.5 3863.3 3869.0 3899.9 4278.7 4318.8 4449.1 4481.4 4496.4 5149.5 5167.8 5214.3 5218.4 5232.5 4400.5 4401.7 4409.8 4447.9 4456.4 4573.2 4625.2 4657.9 4677.4 4706.7 4838.0 4856.3 4858.6 4886.2 4900.4 5161.4 5175.2 5182.7 5190.2 5193.4 4712.4 4897.4 4899.5 4932.4 4955.9 5194.8 5207.3 5210.9 5212.3 5217.0 5292.2 5296.7 5296.9 5307.6 5338.4 4866.5 4957.2 4966.1 4999.2 5032.7 4995.3 5016.7 5024.1 5028.3 5075.3 4836.5 4942.9 4956.6 4997.4 5001.8 4948.7 4970.1 4985.0 4991.7 5011.8 4902.8 4912.9 4914.2 4917.2 4971.8 16:13:03 INFO - PROCESS | 8468 | 16:13:03 INFO - PROCESS | 8468 | [#1] ext.html Cycles:180 Average:46399.90 Median:18645.48 stddev:80817.74 (433.4%) stddev-sans-first:80971.23 16:13:03 INFO - PROCESS | 8468 | Values: 581.9 593.4 593.9 594.7 595.6 38499.6 40270.4 40357.8 43574.1 43605.0 41483.0 41954.2 41962.8 42002.0 42014.6 7628.4 7906.6 8054.8 8060.5 10110.2 9905.9 10295.3 10299.2 10300.8 10304.4 10291.7 10324.4 10337.7 10349.7 10358.2 7677.6 9979.1 10311.1 10312.4 10317.5 10260.1 10343.1 10345.7 10347.3 10353.0 39211.8 39384.2 39572.0 39624.0 39709.8 3204.5 3302.2 3398.8 3417.2 3551.5 29735.1 29776.6 29943.7 29963.7 31081.1 3530.9 3547.7 3550.9 3566.8 3607.5 249286.0 249369.0 249987.0 250099.0 250718.0 51691.0 51745.0 52053.0 52082.2 52623.2 32955.0 33892.2 54223.0 54619.0 54847.5 14514.4 14631.7 14645.4 14659.3 14660.3 9030.9 10679.2 10811.9 10923.6 11063.7 18326.0 18403.6 18405.4 18442.0 18449.4 6878.4 7066.9 7086.8 7093.2 7099.0 910.5 915.6 938.3 950.5 1041.7 28389.0 28407.4 28951.3 29341.1 29385.3 967.4 1032.2 1040.8 1044.3 1061.1 14820.7 15333.6 15338.4 15493.5 15562.7 370314.0 373185.0 374086.0 374207.0 375153.0 49127.0 49540.5 49564.0 49620.3 49705.0 1085.9 1116.3 1186.7 1216.2 1217.8 26640.9 29060.9 29295.7 29535.7 29666.3 41374.6 41602.6 42016.4 42025.6 42047.6 285263.0 288255.0 288773.0 290115.0 290207.0 22247.7 24547.4 25404.0 25482.9 25625.9 41632.4 42004.8 42495.6 42528.4 42924.6 35835.0 36033.8 36747.6 36890.0 37158.4 35696.3 36339.8 36433.8 36532.6 36553.6 35162.0 35678.1 36282.0 36434.3 36442.5 30202.7 32291.0 33003.5 33073.0 33181.2 24539.4 24574.8 24970.3 25348.2 25357.0 16:13:03 INFO - PROCESS | 8468 | 16:13:03 INFO - PROCESS | 8468 | [#2] jquery.html Cycles:180 Average:21748.49 Median:53884.69 stddev:50759.70 (94.2%) stddev-sans-first:50876.73 16:13:03 INFO - PROCESS | 8468 | Values: 375.6 378.6 383.1 385.9 396.9 16023.4 16354.8 17129.1 17270.2 17291.4 15771.8 16565.5 16589.1 16626.8 17305.9 3514.1 4647.8 4848.5 4850.2 4851.7 3618.6 5248.9 5474.6 5480.9 5608.1 5255.9 5587.4 5588.1 5595.0 5603.4 3465.1 5483.1 5607.0 5633.3 5638.1 5039.8 5305.0 5313.5 5412.0 5426.5 11205.9 11316.2 11607.2 12583.2 12982.5 1776.0 1935.8 1971.1 1981.8 2071.9 9281.0 9904.6 9937.7 10890.3 13551.3 1779.8 1968.9 1974.8 2082.7 2084.9 59736.4 61052.4 61843.1 70039.6 82989.0 14764.6 15657.0 16178.9 16246.9 16515.3 29083.3 29281.7 29648.4 29696.9 29750.3 8573.5 8890.5 8904.9 8985.2 9247.0 7370.5 7379.2 7477.7 7504.9 7506.6 7920.0 8295.5 8355.9 8492.9 8678.6 2640.0 3262.2 3277.4 3365.8 3507.6 780.6 862.4 929.0 957.3 964.3 15942.0 16932.7 17632.2 17815.4 18576.2 848.5 855.3 867.2 882.4 931.8 9372.3 9407.8 9740.5 9814.4 9961.9 176256.0 179786.0 179932.0 410947.0 432447.0 78195.6 80180.0 82349.0 82627.0 84277.0 942.3 952.5 980.1 982.1 983.4 15368.0 15651.5 15792.8 16104.5 16141.8 34713.0 36619.0 37121.1 37430.8 38081.4 49128.8 53851.2 53918.2 53921.5 54099.7 7468.8 7570.1 7602.7 7652.5 7705.2 7888.8 10541.8 11206.4 11232.5 11239.2 9728.9 9877.9 9888.0 9897.6 10063.2 10141.6 10195.8 10250.9 10315.2 10329.4 9025.2 9576.9 9800.6 9838.3 9984.3 7190.6 7325.2 7378.5 7405.0 7479.7 8014.4 8312.3 8423.5 9122.3 9248.5 16:13:03 INFO - PROCESS | 8468 | 16:13:03 INFO - PROCESS | 8468 | [#3] mootools.html Cycles:180 Average:5248.49 Median:4741.54 stddev:3008.44 (63.4%) stddev-sans-first:3002.76 16:13:03 INFO - PROCESS | 8468 | Values: 1370.1 1385.0 1423.9 1508.9 1703.3 6961.5 7727.3 7963.4 7979.4 8132.6 8043.8 8051.2 8119.8 8119.9 8133.9 2263.1 2289.9 2293.4 2294.9 2296.5 2187.7 2190.6 2213.6 2223.6 2227.2 2224.5 2233.8 2241.9 2246.5 2255.9 2128.3 2146.6 2147.3 2153.5 2153.6 2168.5 2175.4 2204.2 2205.7 2205.9 7911.9 7985.2 8043.9 8048.2 8053.2 4552.1 4727.6 4733.9 4736.1 4742.0 2819.5 2911.9 2954.6 2965.6 2975.1 871.7 872.9 879.5 880.6 880.7 10971.8 11049.8 11093.4 11095.7 11100.4 4168.7 4256.3 4309.2 4311.9 4340.0 8772.9 8781.0 8815.1 8831.5 8838.0 4718.8 4728.7 4764.0 4768.5 4773.4 3850.5 4255.6 4341.9 4405.8 4428.5 3403.8 3410.4 3497.5 3538.1 3574.9 1046.6 1050.3 1054.9 1060.3 1062.3 695.1 705.3 824.9 843.6 855.0 5189.1 5231.7 5293.2 5301.4 5387.5 426.0 427.4 429.0 451.2 600.7 3371.4 3559.2 3587.4 3599.7 3605.2 9788.2 10039.8 10137.9 10193.0 10205.6 10081.1 10096.8 10108.1 10120.4 10153.4 7280.1 7538.8 7548.1 7561.6 7576.7 5200.7 5234.8 5316.5 5413.6 5532.4 8764.9 9104.1 9117.6 9238.9 9405.1 9147.5 9343.2 9357.9 9359.7 9375.7 6887.2 7008.2 7050.7 7060.7 7065.9 7347.9 7491.8 7548.9 7554.2 7564.1 7035.6 7091.2 7119.9 7266.3 7348.5 6982.5 7082.3 7100.8 7174.5 7212.7 6597.2 6605.2 6638.9 6643.4 6675.2 4417.7 4614.5 4665.0 4680.3 4685.2 4737.3 4741.1 4744.6 4763.4 4786.0 16:13:03 INFO - PROCESS | 8468 | 16:13:03 INFO - PROCESS | 8468 | [#4] prototype.html Cycles:180 Average:4065.81 Median:4391.42 stddev:1171.52 (26.7%) stddev-sans-first:1139.79 16:13:03 INFO - PROCESS | 8468 | Values: 278.2 295.5 300.7 301.3 309.5 4762.1 4883.9 4911.2 4948.1 4957.4 4669.3 4788.6 4795.5 4839.7 4862.7 3824.1 3833.3 3843.8 3861.4 3873.1 3618.0 3692.9 3816.2 3820.7 3827.9 3749.3 3769.2 3788.1 3808.2 3809.5 3759.4 3759.8 3762.2 3763.1 3779.6 3318.5 3325.1 3337.3 3338.2 3345.6 4637.5 4707.1 4749.7 4759.7 4784.5 4339.5 4348.3 4357.2 4362.0 4368.7 5100.4 5134.3 5141.6 5143.5 5145.3 3562.9 3648.2 3659.0 3671.3 3672.9 5274.2 5321.3 5321.7 5325.5 5336.7 3715.7 3719.0 3733.6 3734.6 3748.3 3681.7 3724.9 3755.5 3758.5 3773.5 4315.5 4323.7 4332.6 4337.9 4339.7 5105.6 5107.5 5107.7 5120.9 5136.0 1255.7 1300.3 1327.8 1336.2 1338.9 850.9 863.5 873.4 873.9 876.7 3930.2 3994.2 4001.3 4017.5 4018.2 4595.4 4600.0 4630.5 4638.4 4673.1 3906.3 4011.0 4011.2 4024.6 4028.7 2268.0 2433.2 2463.3 2491.6 2505.7 4318.9 4366.6 4369.0 4385.9 4393.9 4683.0 4744.3 4755.9 4772.8 4789.9 4092.5 4390.9 4391.9 4405.6 4434.5 4592.2 4592.8 4596.8 4639.9 4667.3 4592.0 4603.4 4612.3 4621.5 4643.6 4103.7 4288.0 4298.7 4307.3 4383.9 3470.0 3484.5 3500.8 3513.6 3526.2 4639.3 4667.2 4678.9 4715.7 5082.7 4971.8 5099.5 5141.8 5152.7 5157.5 5113.1 5113.7 5113.9 5120.8 5123.9 4827.4 5010.1 5010.8 5042.3 5052.2 5063.6 5106.4 5118.7 5135.7 5153.2 5014.7 5023.1 5041.4 5044.9 5061.9 16:13:03 INFO - PROCESS | 8468 | 16:13:03 INFO - PROCESS | 8468 | [#5] yui.html Cycles:180 Average:17757.86 Median:587.56 stddev:26514.16 (4512.6%) stddev-sans-first:26557.49 16:13:03 INFO - PROCESS | 8468 | Values: 667.3 682.5 705.4 717.7 773.9 12066.5 12276.6 12328.8 13332.0 13764.9 11643.4 11760.4 11789.5 11860.9 11931.1 626.6 765.4 790.8 809.4 815.5 796.9 810.5 810.9 810.9 810.9 853.4 856.7 857.0 857.2 857.2 649.0 813.1 838.4 850.7 851.7 615.6 616.2 616.2 616.7 617.0 12073.3 12098.0 12169.0 12196.2 12207.2 12278.6 12740.7 12741.7 12810.3 13024.3 11367.6 11369.8 11663.2 11666.8 12087.2 4002.2 4003.1 4079.8 4183.9 4187.2 59831.4 60378.0 60655.7 60796.8 60959.7 9797.8 10276.7 10304.9 10395.9 10559.7 15998.2 16183.9 16222.8 16225.8 16239.6 6534.2 6562.3 6583.9 6868.8 7017.4 3665.1 3704.4 3707.9 3763.2 3795.9 2915.1 2999.1 3004.2 3005.4 3005.6 549.0 580.9 585.2 589.4 597.3 554.7 560.4 565.7 570.7 577.8 7396.0 7414.2 7592.4 7693.6 7985.6 555.8 566.5 574.4 578.5 585.7 3748.7 3755.4 3792.9 3904.9 3916.6 94807.5 99557.0 99671.5 100603.0 101840.5 89502.0 89666.0 91384.5 91652.5 92707.0 78125.6 78265.6 79447.2 79902.6 80008.6 7316.3 7343.7 7521.8 7577.8 7698.8 45308.0 46082.8 46433.8 46921.3 46953.3 55023.7 67590.0 67785.0 68434.7 68509.3 8823.5 8832.8 8850.3 8935.0 9269.3 10868.5 10922.9 10944.3 11071.6 11072.4 10027.9 10072.2 10168.4 10172.6 10175.9 10063.8 10128.5 10425.8 10463.4 10637.8 9506.3 9537.8 9736.8 9975.4 10175.6 7919.2 8106.4 8426.9 8541.8 8655.8 8553.8 8800.6 8844.9 8879.0 8969.6 16:13:03 INFO - PROCESS | 8468 | -------- Summary: end -------- 16:13:03 INFO - PROCESS | 8468 | 16:13:04 INFO - TEST-INFO | 8468: exit 0 16:13:04 INFO - TEST-OK | dromaeo_css | took 1121810ms 16:13:04 INFO - TEST-START | kraken 16:13:04 INFO - operating with platform_type : linux_ 16:13:04 INFO - Initialising browser for kraken test... 16:13:04 INFO - TEST-INFO | started process 8644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzLwZrR/profile http://localhost:33423/getInfo.html) 16:13:09 INFO - PROCESS | 8644 | __metrics Screen width/height:1600/1200 16:13:09 INFO - PROCESS | 8644 | colorDepth:24 16:13:09 INFO - PROCESS | 8644 | Browser inner width/height: 1024/697 16:13:09 INFO - PROCESS | 8644 | __metrics 16:13:10 INFO - PROCESS | 8644 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:13:11 INFO - PROCESS | 8644 | console.error: PushService: 16:13:11 INFO - PROCESS | 8644 | stateChangeProcessEnqueue: Error transitioning state 16:13:11 INFO - PROCESS | 8644 | UnknownError 16:13:11 INFO - TEST-INFO | 8644: exit 0 16:13:11 INFO - Browser initialized. 16:13:11 INFO - Running cycle 1/1 for kraken test... 16:13:11 INFO - TEST-INFO | started process 8725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzLwZrR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:24 INFO - PROCESS | 8725 | RSS: Main: 175153152 16:13:24 INFO - PROCESS | 8725 | 16:13:26 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33423/tests/kraken/driver.html?testName=audio-beat-detection) 16:13:27 INFO - PROCESS | 8725 | RSS: Main: 233705472 16:13:27 INFO - PROCESS | 8725 | 16:13:30 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33423/tests/kraken/driver.html?testName=audio-dft) 16:13:31 INFO - PROCESS | 8725 | RSS: Main: 221966336 16:13:31 INFO - PROCESS | 8725 | 16:13:34 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33423/tests/kraken/driver.html?testName=audio-fft) 16:13:35 INFO - PROCESS | 8725 | RSS: Main: 289189888 16:13:35 INFO - PROCESS | 8725 | 16:13:37 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33423/tests/kraken/driver.html?testName=audio-oscillator) 16:13:37 INFO - PROCESS | 8725 | RSS: Main: 199237632 16:13:37 INFO - PROCESS | 8725 | 16:13:40 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33423/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:40 INFO - PROCESS | 8725 | RSS: Main: 202448896 16:13:40 INFO - PROCESS | 8725 | 16:13:43 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33423/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:44 INFO - PROCESS | 8725 | RSS: Main: 238813184 16:13:44 INFO - PROCESS | 8725 | 16:13:47 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33423/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:48 INFO - PROCESS | 8725 | RSS: Main: 234893312 16:13:48 INFO - PROCESS | 8725 | 16:13:51 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33423/tests/kraken/driver.html?testName=json-parse-financial) 16:13:52 INFO - PROCESS | 8725 | RSS: Main: 237445120 16:13:52 INFO - PROCESS | 8725 | 16:13:53 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33423/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:54 INFO - PROCESS | 8725 | RSS: Main: 224055296 16:13:54 INFO - PROCESS | 8725 | 16:13:56 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33423/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:56 INFO - PROCESS | 8725 | RSS: Main: 230572032 16:13:56 INFO - PROCESS | 8725 | 16:13:59 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33423/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:59 INFO - PROCESS | 8725 | RSS: Main: 238477312 16:13:59 INFO - PROCESS | 8725 | 16:14:02 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:14:03 INFO - PROCESS | 8725 | RSS: Main: 240582656 16:14:03 INFO - PROCESS | 8725 | 16:14:06 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:06 INFO - PROCESS | 8725 | RSS: Main: 239988736 16:14:06 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:33423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33423/tests/kraken/driver.html?testName=ai-astar) 16:14:08 INFO - PROCESS | 8725 | RSS: Main: 283607040 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | __start_tp_report 16:14:08 INFO - PROCESS | 8725 | _x_x_mozilla_page_load 16:14:08 INFO - PROCESS | 8725 | _x_x_mozilla_page_load_details 16:14:08 INFO - PROCESS | 8725 | |i|pagename|runs| 16:14:08 INFO - PROCESS | 8725 | |0;ai-astar;114;111;113;115;114;114;113;114;113;113 16:14:08 INFO - PROCESS | 8725 | |1;audio-beat-detection;162;131;144;189;138;153;155;140;188;130 16:14:08 INFO - PROCESS | 8725 | |2;audio-dft;163;162;163;160;162;161;162;160;161;161 16:14:08 INFO - PROCESS | 8725 | |3;audio-fft;74;75;76;101;76;75;75;80;100;76 16:14:08 INFO - PROCESS | 8725 | |4;audio-oscillator;87;86;121;86;87;86;124;86;86;133 16:14:08 INFO - PROCESS | 8725 | |5;imaging-gaussian-blur;117;116;116;116;117;117;117;117;117;117 16:14:08 INFO - PROCESS | 8725 | |6;imaging-darkroom;145;146;146;147;147;147;146;147;147;147 16:14:08 INFO - PROCESS | 8725 | |7;imaging-desaturate;94;94;95;97;96;95;95;95;94;95 16:14:08 INFO - PROCESS | 8725 | |8;json-parse-financial;63;63;63;63;65;62;62;62;62;63 16:14:08 INFO - PROCESS | 8725 | |9;json-stringify-tinderbox;65;66;66;64;65;65;67;65;66;67 16:14:08 INFO - PROCESS | 8725 | |10;stanford-crypto-aes;83;83;82;83;83;85;84;84;114;83 16:14:08 INFO - PROCESS | 8725 | |11;stanford-crypto-ccm;142;138;133;131;136;127;132;142;150;138 16:14:08 INFO - PROCESS | 8725 | |12;stanford-crypto-pbkdf2;169;169;171;170;176;172;170;168;168;171 16:14:08 INFO - PROCESS | 8725 | |13;stanford-crypto-sha256-iterative;70;67;70;70;69;72;69;67;68;65 16:14:08 INFO - PROCESS | 8725 | __end_tp_report 16:14:08 INFO - PROCESS | 8725 | __start_cc_report 16:14:08 INFO - PROCESS | 8725 | _x_x_mozilla_cycle_collect,1925 16:14:08 INFO - PROCESS | 8725 | __end_cc_report 16:14:08 INFO - PROCESS | 8725 | __startTimestamp1465859648806__endTimestamp 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | ------- Summary: start ------- 16:14:08 INFO - PROCESS | 8725 | Number of tests: 14 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.12 16:14:08 INFO - PROCESS | 8725 | Values: 114.0 111.0 113.0 115.0 114.0 114.0 113.0 114.0 113.0 113.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:154.00 stddev:21.33 (13.8%) stddev-sans-first:22.37 16:14:08 INFO - PROCESS | 8725 | Values: 162.0 131.0 144.0 189.0 138.0 153.0 155.0 140.0 188.0 130.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 16:14:08 INFO - PROCESS | 8725 | Values: 163.0 162.0 163.0 160.0 162.0 161.0 162.0 160.0 161.0 161.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.50 stddev:10.51 (13.9%) stddev-sans-first:10.85 16:14:08 INFO - PROCESS | 8725 | Values: 74.0 75.0 76.0 101.0 76.0 75.0 75.0 80.0 100.0 76.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:86.00 stddev:19.41 (22.6%) stddev-sans-first:20.16 16:14:08 INFO - PROCESS | 8725 | Values: 87.0 86.0 121.0 86.0 87.0 86.0 124.0 86.0 86.0 133.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:14:08 INFO - PROCESS | 8725 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.71 (0.5%) stddev-sans-first:0.50 16:14:08 INFO - PROCESS | 8725 | Values: 145.0 146.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 16:14:08 INFO - PROCESS | 8725 | Values: 94.0 94.0 95.0 97.0 96.0 95.0 95.0 95.0 94.0 95.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 16:14:08 INFO - PROCESS | 8725 | Values: 63.0 63.0 63.0 63.0 65.0 62.0 62.0 62.0 62.0 63.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 16:14:08 INFO - PROCESS | 8725 | Values: 65.0 66.0 66.0 64.0 65.0 65.0 67.0 65.0 66.0 67.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:83.00 stddev:9.73 (11.7%) stddev-sans-first:10.24 16:14:08 INFO - PROCESS | 8725 | Values: 83.0 83.0 82.0 83.0 83.0 85.0 84.0 84.0 114.0 83.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:138.00 stddev:6.66 (4.8%) stddev-sans-first:6.80 16:14:08 INFO - PROCESS | 8725 | Values: 142.0 138.0 133.0 131.0 136.0 127.0 132.0 142.0 150.0 138.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:170.50 stddev:2.37 (1.4%) stddev-sans-first:2.46 16:14:08 INFO - PROCESS | 8725 | Values: 169.0 169.0 171.0 170.0 176.0 172.0 170.0 168.0 168.0 171.0 16:14:08 INFO - PROCESS | 8725 | 16:14:08 INFO - PROCESS | 8725 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:2.00 (2.9%) stddev-sans-first:2.07 16:14:08 INFO - PROCESS | 8725 | Values: 70.0 67.0 70.0 70.0 69.0 72.0 69.0 67.0 68.0 65.0 16:14:08 INFO - PROCESS | 8725 | -------- Summary: end -------- 16:14:08 INFO - PROCESS | 8725 | 16:14:09 INFO - TEST-INFO | 8725: exit 0 16:14:09 INFO - TEST-OK | kraken | took 65580ms 16:14:09 INFO - SUITE-END | took 1187s 16:14:09 INFO - Completed test suite (00:19:47) 16:14:09 INFO - javascript benchmark 16:14:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2574.755398237167, 2607.3611965068553, 2622.3837398211417, 2625.671791026122, 2657.3622330640646, 4639.744814035227, 4737.1946769049255, 4738.668293219476, 4804.927926081107, 4827.806887724491, 4784.712917224969, 4828.0, 4837.201861692816, 4843.225083986563, 4849.248366503189, 4396.494403143647, 4425.336199570058, 4464.553544645542, 4528.04910968697, 4632.907341853161, 4579.610733087691, 4589.196890544158, 4600.378948841913, 4613.077384523092, 4635.049814787961, 4330.740155590659, 4363.498197707273, 4379.43067401239, 4403.977980110111, 4429.557044295577, 4380.189664912002, 4381.9342709859375, 4392.626626736699, 4449.7330160190495, 4475.216837053503, 4404.163208990313, 4418.734875907424, 4426.867193984185, 4468.419105516295, 4471.8658440246845, 4716.363290955712, 4830.29960655703, 4882.609391248691, 4887.340209071801, 4904.411470623512, 5254.448282930313, 5273.841784746425, 5307.442718514539, 5330.653507522037, 5335.279737235463, 5328.254044433782, 5367.194920761878, 5367.838964831022, 5369.892602147975, 5372.892542149135, 4711.222648263032, 4736.052789442126, 4782.33047373368, 4786.994731106437, 4809.95190048102, 5271.4728527147745, 5306.814261500829, 5307.6284660073425, 5309.256704061435, 5309.734513274321, 4950.158473059589, 5085.415177254663, 5091.770870310845, 5104.9744751276, 5106.259592359087, 5082.263071854561, 5118.462561431071, 5124.897502050013, 5127.743612819344, 5149.897002060013, 5092.185250359925, 5101.69592619837, 5101.719405432663, 5106.438291787975, 5161.948380516222, 4948.331975183376, 5076.0, 5089.567386772092, 5092.0579692756955, 5104.668196567211, 4391.3193455014525, 4401.207782599163, 4419.292913133948, 4459.375687403766, 4463.977680111579, 3841.3469710149343, 3852.5184351956004, 3863.285292220948, 3868.9806550967064, 3899.902502437405, 4278.657707383401, 4318.762468064287, 4449.110177964355, 4481.417415735934, 4496.437945256843, 5149.45930677281, 5167.819126330561, 5214.2960700304975, 5218.399884013387, 5232.502912223333, 4400.471943366816, 4401.691881568324, 4409.801558929856, 4447.866564003085, 4456.3538286948215, 4573.199690054294, 4625.213713668684, 4657.883552911204, 4677.438707355139, 4706.694064885772, 4838.0, 4856.295837103529, 4858.562729354375, 4886.218205087312, 4900.387451568483, 5161.432242453252, 5175.171972484384, 5182.740862956762, 5190.195519694454, 5193.42872284056, 4712.410948631421, 4897.36334276556, 4899.510048995072, 4932.4327702314695, 4955.876103097451, 5194.766235519335, 5207.297014903091, 5210.869728256824, 5212.322398088376, 5216.9739151304, 5292.20616907467, 5296.708681022581, 5296.894062118659, 5307.575393968396, 5338.386085600206, 4866.489018653132, 4957.206846904478, 4966.081274964144, 4999.200127979506, 5032.723200224023, 4995.300657907823, 5016.724080175625, 5024.070546948826, 5028.321176641253, 5075.3402057732255, 4836.492168322417, 4942.8764280893265, 4956.578690811177, 4997.400311962588, 5001.824936127364, 4948.727819969936, 4970.055689419143, 4984.950150498448, 4991.650584459053, 5011.774470148779, 4902.779374928065, 4912.901741965069, 4914.189158788903, 4917.188663870565, 4971.776270067928], "value": 4744.6237556135575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.8603535151562, 593.4303069053708, 593.8604427959428, 594.6640148316201, 595.559286128265, 38499.615003849955, 40270.39594406082, 40357.79821100894, 43574.12851742971, 43605.0, 41483.0, 41954.16091678172, 41962.790186049104, 42002.0, 42014.579854201445, 7628.389728821681, 7906.604669766518, 8054.798630034237, 8060.476069055522, 10110.241731870103, 9905.900940990607, 10295.279330446872, 10299.227557933147, 10300.845487317696, 10304.433256170907, 10291.742706432324, 10324.432156231442, 10337.741556461073, 10349.689509314732, 10358.223133264997, 7677.577733224698, 9979.10188083076, 10311.123554497877, 10312.381257124522, 10317.484125793755, 10260.076593106582, 10343.120834729058, 10345.741356466073, 10347.327423717434, 10353.0, 39211.8039409804, 39384.212315753524, 39572.0, 39624.0, 39709.80145099285, 3204.5033019881957, 3302.207470207133, 3398.8130652814084, 3417.2311229973056, 3551.485034669958, 29735.107946761633, 29776.553351699742, 29943.70056299431, 29963.700362996307, 31081.067567972997, 3530.9293814123575, 3547.7050876430176, 3550.8934731958084, 3566.82681262923, 3607.549056367954, 249285.9999999982, 249369.0, 249987.0, 250099.0, 250718.0, 51691.0, 51745.0, 52053.0, 52082.21876671853, 52623.21065184025, 32955.0, 33892.15269618279, 54223.0, 54619.0, 54847.45152548423, 14514.419423222953, 14631.707365852624, 14645.414183432757, 14659.267036648338, 14660.340284687001, 9030.86453703195, 10679.199060070527, 10811.891881081247, 10923.563057477611, 11063.668089957315, 18326.0, 18403.631927361646, 18405.355812546495, 18442.0, 18449.446516604523, 6878.415334696507, 7066.893996590055, 7086.751963681247, 7093.219745827955, 7099.0, 910.544727636182, 915.5971372596036, 938.3056538161848, 950.5057370167474, 1041.6770801051698, 28389.0, 28407.43185136327, 28951.276218094717, 29341.119766407042, 29385.265368365534, 967.3567077893263, 1032.1897310611134, 1040.7710303733168, 1044.3420644993757, 1061.0556604621893, 14820.70358592822, 15333.6166595836, 15338.386464541516, 15493.535193944199, 15562.688746225012, 370314.0, 373185.0, 374086.0, 374207.0, 375153.0, 49127.0, 49540.50459495431, 49564.0, 49620.25569616459, 49705.0, 1085.913126949842, 1116.3134672176716, 1186.665001872893, 1216.2398500936915, 1217.7686239614623, 26640.866795665897, 29060.854695726386, 29295.707042929298, 29535.704642954155, 29666.258343541584, 41374.58625413707, 41602.58397416108, 42016.369754453095, 42025.579744202165, 42047.57952420559, 285263.0, 288255.0, 288773.0, 290115.0, 290207.0, 22247.66628500606, 24547.38631534226, 25404.0, 25482.872585636953, 25625.92488901269, 41632.375514367915, 42004.78997604993, 42495.5750442504, 42528.362074568286, 42924.57075429331, 35835.0, 36033.81983090068, 36747.63252367549, 36890.0, 37158.44262336121, 35696.28607427889, 36339.81830090833, 36433.81783091067, 36532.616086069844, 36553.63446365502, 35162.0, 35678.10804729799, 36282.0, 36434.27131457409, 36442.45336319904, 30202.69797301999, 32291.0, 33003.504947426285, 33073.0, 33181.17047073843, 24539.38651533726, 24574.754252457245, 24970.250892473254, 25348.239552813444, 25357.0], "value": 18135.101804491827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.6243756243756, 378.60814057450534, 383.13411689581574, 385.9266739319531, 396.928552860485, 16023.439179628715, 16354.83645163548, 17129.057901815395, 17270.2228399722, 17291.394801181945, 15771.763423548657, 16565.503034908943, 16589.087600181985, 16626.75059874103, 17305.91347043266, 3514.1390359361994, 4647.7676116194225, 4848.539388758062, 4850.199717046683, 4851.733154676492, 3618.6019537850816, 5248.895022099575, 5474.589405794562, 5480.862978425552, 5608.074667679828, 5255.894882102356, 5587.441255874421, 5588.105903055512, 5594.9720251398685, 5603.439656034405, 3465.1337165708574, 5483.122700367922, 5607.046802043622, 5633.267675202238, 5638.069718496443, 5039.84880453587, 5305.0, 5313.548348390392, 5412.025835349636, 5426.457354264581, 11205.887941120565, 11316.151288653384, 11607.245529040585, 12583.182093163916, 12982.545610903573, 1775.9556011099696, 1935.8064193580528, 1971.1327016112864, 1981.782003979561, 2071.927482538104, 9281.0, 9904.55429505674, 9937.65218217359, 10890.292131011538, 13551.322433878267, 1779.7597324361175, 1968.881867087965, 1974.8123928226796, 2082.6771850363216, 2084.8957552122333, 59736.40263597395, 61052.38947610511, 61843.07235391518, 70039.64980175118, 82989.0, 14764.63088422798, 15656.954370533305, 16178.919105404397, 16246.918765406097, 16515.256813443422, 29083.27291817679, 29281.707182928323, 29648.407031859242, 29696.851515742284, 29750.25624359365, 8573.528455934858, 8890.511021893728, 8904.910950890539, 8985.236254918274, 9247.0, 7370.520916140434, 7379.188289288174, 7477.70089196426, 7504.887426688604, 7506.573750987295, 7919.990403646692, 8295.543745093957, 8355.874661880076, 8492.872606910902, 8678.56607169639, 2640.0, 3262.151840521434, 3277.3609146216736, 3365.8148801815646, 3507.649235076472, 780.6252998560723, 862.3963225742006, 928.9628414863465, 957.3250858144991, 964.3297907953905, 15942.0, 16932.746008809878, 17632.20655070525, 17815.376461823773, 18576.164072616764, 848.4909054567333, 855.3371137368465, 867.2065060469599, 882.373514804496, 931.7624005878594, 9372.343935924557, 9407.811843763086, 9740.46427446483, 9814.362066465657, 9961.850572241423, 176256.0, 179786.0, 179932.0, 410947.0, 432447.0, 78195.60902195566, 80180.0, 82349.0, 82627.0, 84277.0, 942.2791564453199, 952.5380190607411, 980.1472718734747, 982.0964712464549, 983.4050399508337, 15368.0, 15651.530454086396, 15792.76310855315, 16104.516864494084, 16141.75787363214, 34712.9586112417, 36619.0, 37121.07197320089, 37430.812845936685, 38081.42877856779, 49128.75435622799, 53851.19223211733, 53918.19122713084, 53921.46078539321, 54099.67202623859, 7468.813279668052, 7570.129435115033, 7602.7339043133225, 7652.464327497022, 7705.1524332324525, 7888.802779930547, 10541.78916421652, 11206.38364889939, 11232.494537745657, 11239.157063220127, 9728.854067188857, 9877.901220987698, 9888.0, 9897.604095836374, 10063.245256605931, 10141.594336226763, 10195.84706229422, 10250.942273358341, 10315.17478601725, 10329.431881246604, 9025.187733104052, 9576.90423095788, 9800.558974846292, 9838.26213034011, 9984.301098923006, 7190.604516751419, 7325.230850760593, 7378.520396174232, 7404.96297518509, 7479.70081196746, 8014.398920080901, 8312.33501319905, 8423.452475589067, 9122.27021838238, 9248.537573121452], "value": 8607.468618222932, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.0615078671105, 1384.9653758656032, 1423.9288035598217, 1508.9245537723111, 1703.2904020383633, 6961.477889158315, 7727.265909738573, 7963.362930965523, 7979.441439099265, 8132.634031468583, 8043.839123217532, 8051.154628763983, 8119.756407307776, 8119.9188008120045, 8133.877991830127, 2263.0721404224314, 2289.896954637037, 2293.4266433391654, 2294.908203671851, 2296.540691861626, 2187.6718492226214, 2190.5728382965326, 2213.6236839737285, 2223.6442169252923, 2227.1982086448947, 2224.477247846755, 2233.7877901599322, 2241.8991145398413, 2246.472079061419, 2255.9210427635035, 2128.265748316828, 2146.602878467481, 2147.3021268087778, 2153.5477549714656, 2153.6338822400153, 2168.4687251623454, 2175.380016695234, 2204.1624182810588, 2205.7022301989346, 2205.922792702264, 7911.920880791176, 7985.2014798519685, 8043.919560804434, 8048.195180481964, 8053.154418786002, 4552.089582083597, 4727.550882666142, 4733.905321893543, 4736.100140973204, 4741.952580474185, 2819.4643017826547, 2911.883524659011, 2954.6011288475997, 2965.648816836982, 2975.1074677596635, 871.6818361298144, 872.8559787635032, 879.5470332778624, 880.5861245214738, 880.7049638371153, 10971.780564388668, 11049.779004419946, 11093.445327733582, 11095.667129986032, 11100.444977751162, 4168.6665066794585, 4256.3189889617515, 4309.224339618899, 4311.8706438806885, 4340.023494713727, 8772.868406973901, 8780.956095219482, 8815.118488151134, 8831.470111793184, 8838.0, 4718.811247550059, 4728.668993170514, 4763.95236047642, 4768.523147685204, 4773.427188737373, 3850.5186851643543, 4255.5744425557195, 4341.934870976938, 4405.84579539721, 4428.512863585003, 3403.7617366784584, 3410.3861304965344, 3497.4753786931656, 3538.062413460435, 3574.857005719794, 1046.6179844356907, 1050.2963014780116, 1054.9419781912068, 1060.3319908457622, 1062.293574772783, 695.0616667498836, 705.3264132753209, 824.9175082491703, 843.6330196364601, 854.9871751923727, 5189.117849965515, 5231.738413079407, 5293.232481290192, 5301.390340110936, 5387.461253874581, 425.9850905218303, 427.37389724054407, 429.0132694802005, 451.1630924634821, 600.7114738885067, 3371.443711787577, 3559.1635965548076, 3587.3901436755814, 3599.6940260077663, 3605.170810713498, 9788.168005719452, 10039.849402258971, 10137.949310253549, 10192.980701929897, 10205.591776329013, 10081.143102836195, 10096.848547271797, 10108.140808031252, 10120.392776433437, 10153.39079655223, 7280.089988751406, 7538.811529711801, 7548.094228692592, 7561.621918904033, 7576.7348142814735, 5200.713960732196, 5234.816781412632, 5316.494932981361, 5413.56691464674, 5532.446755324436, 8764.91235087641, 9104.089591040844, 9117.635294588143, 9238.907610923805, 9405.05949405054, 9147.451152930846, 9343.205827504738, 9357.906420935704, 9359.67241146584, 9375.718728438158, 6887.2079710831895, 7008.22909479967, 7050.682719277747, 7060.71757129709, 7065.894011589933, 7347.926520734938, 7491.812704682427, 7548.924510755041, 7554.206808285271, 7564.130125035691, 7035.648217589202, 7091.184513780981, 7119.857602848017, 7266.309700578437, 7348.485606007528, 6982.546134501241, 7082.291770822876, 7100.822479438056, 7174.533655312388, 7212.71149154028, 6597.208334999831, 6605.207375115017, 6638.867222655616, 6643.368879956396, 6675.23234828001, 4417.668674849463, 4614.515475874985, 4665.04366604852, 4680.321353403806, 4685.203515402458, 4737.28940658904, 4741.122892264942, 4744.644151688706, 4763.404574428197, 4786.042791441795], "value": 4120.693159932283, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.2348541510844, 295.47700569991116, 300.7218323051177, 301.2754325846339, 309.4769838972137, 4762.095161935227, 4883.926741098886, 4911.165101932671, 4948.109340318746, 4957.380327459072, 4669.276262179367, 4788.592969597588, 4795.520447955203, 4839.741667166536, 4862.7325497097645, 3824.063104539378, 3833.290841194374, 3843.8078096095223, 3861.4014827701612, 3873.128546077124, 3618.0, 3692.9076773080756, 3816.160444702161, 3820.675242604368, 3827.9043023924487, 3749.343864823645, 3769.18962423079, 3788.109794198361, 3808.21931504041, 3809.4857194278834, 3759.398496240602, 3759.793211373373, 3762.2287431076566, 3763.07804587875, 3779.622037796226, 3318.5188147718445, 3325.068980685412, 3337.2991671748964, 3338.2322065924973, 3345.6152542457444, 4637.489876113625, 4707.058588282357, 4749.667523273372, 4759.738214398207, 4784.497627749071, 4339.457567804025, 4348.260795664744, 4357.193919124972, 4361.978190109061, 4368.716033457815, 5100.438951715309, 5134.332536770196, 5141.614378921596, 5143.459936706629, 5145.30538377318, 3562.928741425183, 3648.1973965727498, 3658.963410365889, 3671.3208056509366, 3672.889813305605, 5274.235235890813, 5321.3348331458565, 5321.654092484015, 5325.4940780625775, 5336.67979921206, 3715.684166845794, 3718.9814050930113, 3733.5893051764283, 3734.589195188527, 3748.2690875279604, 3681.7238707097076, 3724.8557326692553, 3755.511783468132, 3758.473813666089, 3773.4905787718853, 4315.4605674290715, 4323.740575565414, 4332.631726303236, 4337.869863904025, 4339.674524410681, 5105.617078719111, 5107.489251074863, 5107.668001579886, 5120.897582048338, 5136.0, 1255.7049093463029, 1300.3498250874563, 1327.8074679171466, 1336.1648969394128, 1338.8527262001367, 850.9489430634181, 863.451708165307, 873.366809063424, 873.9169778870997, 876.7282142535835, 3930.21395720857, 3994.201159768058, 4001.299772539794, 4017.5379831319774, 4018.1963607278662, 4595.357669340143, 4599.953020905665, 4630.536946305342, 4638.397008388955, 4673.060679817838, 3906.277338692294, 4010.9598904010586, 4011.1777085697363, 4024.557298697141, 4028.6906755304644, 2268.00226800225, 2433.2213691618867, 2463.300322777278, 2491.601343785022, 2505.6993160820816, 4318.935215971763, 4366.580861220116, 4369.0, 4385.934210986838, 4393.857597024797, 4683.0, 4744.299446431789, 4755.881102972384, 4772.76136193189, 4789.928151077736, 4092.5444733159866, 4390.924223565247, 4391.912161756747, 4405.559444055569, 4434.534373890695, 4592.242280023758, 4592.816287348603, 4596.770161491845, 4639.930401044055, 4667.32323813052, 4592.048379438658, 4603.424571928509, 4612.310151878551, 4621.537846215351, 4643.628509719147, 4103.692223083341, 4287.970886987163, 4298.667413101948, 4307.267764479983, 4383.912321753611, 3469.9653003470653, 3484.494748261437, 3500.8097246936163, 3513.5945621751503, 3526.18897653536, 4639.32729754177, 4667.229907065296, 4678.883027924329, 4715.740634265148, 5082.745862706776, 4971.776270067783, 5099.495648783543, 5141.820036298712, 5152.6650767699975, 5157.510036546522, 5113.079645663816, 5113.696007518059, 5113.8977220454635, 5120.795168193231, 5123.948760512347, 4827.42070951488, 5010.148274793221, 5010.8246211383885, 5042.319286896369, 5052.242163675478, 5063.5695965843315, 5106.412762532208, 5118.744062796771, 5135.690398948244, 5153.175491921274, 5014.671112155354, 5023.146065169003, 5041.395032596112, 5044.949550504448, 5061.9493805061475], "value": 3699.582544307142, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.2593421302354, 682.5290549520834, 705.3933617089302, 717.6949796336555, 773.8877862709905, 12066.457009434575, 12276.5703200388, 12328.81506777398, 13332.0, 13764.862351376483, 11643.35961522116, 11760.411979401038, 11789.469473873674, 11860.881391186085, 11931.105167112459, 626.6271568416807, 765.4029856711774, 790.8260182759784, 809.4495742894829, 815.4903185509057, 796.8685166947475, 810.4569938141459, 810.8580998325299, 810.8621534339177, 810.8824220488026, 853.4282031039219, 856.6530555125184, 856.9571521423935, 857.1856736100698, 857.1985193843744, 648.9772857949949, 813.0812182234097, 838.4005436113208, 850.740524140137, 851.6678495386805, 615.5814046448413, 616.1743264026227, 616.2389449030444, 616.7193926763312, 616.9973792587047, 12073.275603463733, 12098.0, 12169.026477881749, 12196.207246528948, 12207.206531575508, 12278.570250041206, 12740.681482962907, 12741.681457963532, 12810.267345576296, 13024.283664398454, 11367.602133925355, 11369.772604547863, 11663.183577149603, 11666.824997624957, 12087.21433106854, 4002.199560087994, 4003.099302656908, 4079.8368065277355, 4183.853565125237, 4187.1625674865145, 59831.401685983015, 60378.0, 60655.69672151655, 60796.78406431847, 60959.695201524155, 9797.80404391908, 10276.691699249035, 10304.948475257575, 10395.94802025985, 10559.683209503728, 15998.200089995453, 16183.919080404523, 16222.83777162237, 16225.756613650805, 16239.59401014984, 6534.215894092739, 6562.278149403562, 6583.9012414813815, 6868.828279292958, 7017.3684368407085, 3665.138692407282, 3704.407294832814, 3707.94438083429, 3763.2097259575794, 3795.9430608540893, 2915.1400336900665, 2999.100269919059, 3004.1888690053565, 3005.383896301253, 3005.594244776927, 548.958828087887, 580.8634970781862, 585.1924344404695, 589.3693747689931, 597.333972620525, 554.692145859044, 560.3751816724323, 565.7397597105295, 570.7003822992879, 577.8270111673226, 7395.963020184972, 7414.221506741822, 7592.354649854714, 7693.576853273012, 7985.560794156261, 555.849920521465, 566.4646908671266, 574.3968832725621, 578.4967078641524, 585.748128304833, 3748.7188460865545, 3755.4179102239195, 3792.943105853414, 3904.902377440587, 3916.6475017248586, 94807.52596236975, 99557.0, 99671.50164249132, 100603.0, 101840.49079754703, 89502.0, 89666.0, 91384.5430772842, 91652.54173729089, 92707.0, 78125.60937195392, 78265.60867195627, 79447.20552794513, 79902.6004869972, 80008.59995699984, 7316.268373162641, 7343.70625174987, 7521.7743467696055, 7577.810554736176, 7698.769036928677, 45308.0, 46082.76958615185, 46433.76783116063, 46921.296180558005, 46953.2957005652, 55023.72488137534, 67590.0, 67785.0, 68434.65782671055, 68509.3149068503, 8823.470591764259, 8832.823343533222, 8850.291976641724, 8934.955325223333, 9269.30480214, 10868.478413022342, 10922.945385273022, 10944.343339399662, 11071.612493562687, 11072.39101849406, 10027.949860250652, 10072.194224461879, 10168.440735759605, 10172.643957461454, 10175.949120254352, 10063.798724025624, 10128.493575321352, 10425.843612345972, 10463.424511651629, 10637.840432393676, 9506.334556581249, 9537.761555960878, 9736.821149864774, 9975.401475911469, 10175.592976280866, 7919.208079192034, 8106.432549721463, 8426.915730842613, 8541.829163416573, 8655.783605409915, 8553.82892342162, 8800.647974080965, 8844.867326990228, 8879.0, 8969.638919652483], "value": 6393.68428393819, "unit": "score"}], "name": "dromaeo_css", "value": 6452.886670604268, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 113.0, 115.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 131.0, 144.0, 189.0, 138.0, 153.0, 155.0, 140.0, 188.0, 130.0], "value": 153.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 160.0, 162.0, 161.0, 162.0, 160.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 101.0, 76.0, 75.0, 75.0, 80.0, 100.0, 76.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 121.0, 86.0, 87.0, 86.0, 124.0, 86.0, 86.0, 133.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 97.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 65.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 64.0, 65.0, 65.0, 67.0, 65.0, 66.0, 67.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 83.0, 83.0, 85.0, 84.0, 84.0, 114.0, 83.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 138.0, 133.0, 131.0, 136.0, 127.0, 132.0, 142.0, 150.0, 138.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 171.0, 170.0, 176.0, 172.0, 170.0, 168.0, 168.0, 171.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 70.0, 70.0, 69.0, 72.0, 69.0, 67.0, 68.0, 65.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1555.9000000000003, "alertThreshold": 2.0}]} 16:14:10 INFO - Return code: 0 16:14:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:14:10 INFO - # TBPL SUCCESS # 16:14:10 INFO - Running post-action listener: _resource_record_post_action 16:14:10 INFO - ##### 16:14:10 INFO - ##### Finished run-tests step (success) 16:14:10 INFO - ##### 16:14:10 INFO - Running post-run listener: _resource_record_post_run 16:14:10 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551538688; Read time: 8; Write time: 1637760 16:14:10 INFO - TinderboxPrint: CPU usage
13.4% 16:14:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:14:10 INFO - TinderboxPrint: I/O write bytes / time
551,538,688 / 1,637,760 16:14:10 INFO - TinderboxPrint: CPU idle
8,336.1 (86.6%) 16:14:10 INFO - TinderboxPrint: CPU user
1,223.0 (12.7%) 16:14:10 INFO - TinderboxPrint: Swap in / out
0 / 0 16:14:10 INFO - install - Wall time: 17s; CPU: 20.0%; Read bytes: 0; Write bytes: 262221824; Read time: 0; Write time: 1158868 16:14:10 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289263616; Read time: 8; Write time: 478868 16:14:10 INFO - Running post-run listener: _upload_blobber_files 16:14:10 INFO - Blob upload gear active. 16:14:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:14:10 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 16:14:10 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:14:10 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:14:11 INFO - (blobuploader) - INFO - Open directory for files ... 16:14:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:14:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:14:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:15 INFO - (blobuploader) - INFO - Done attempting. 16:14:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:14:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:14:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:16 INFO - (blobuploader) - INFO - Done attempting. 16:14:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:14:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:14:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:16 INFO - (blobuploader) - INFO - Done attempting. 16:14:16 INFO - (blobuploader) - INFO - Iteration through files over. 16:14:16 INFO - Return code: 0 16:14:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:14:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:14:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9b3b890dbba819d48fe1707b8748435f3b3ec93b15c32ef369382fe6ff395e95e2e10f7ae39227bef51455245ae51490dcf5faa7a710e9af1ad3da8cf17f1f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6defb0bfe7b62d1f39420fcec64247023d16c62e63354208c6bbb6c68685ebb7135ff85bd06516cf94a01819143b781015c1c6d548ca809571be436e6b85b45e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a82a8a0b0236cb60c89b34d880dbbaaa0c49c78d58fb0dc2d1ba284afc01ca82fec327c678051df0067a8ada30eaf03d086044aca3b02421bfc7d33e75a83baf"} 16:14:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:14:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:14:16 INFO - Contents: 16:14:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9b3b890dbba819d48fe1707b8748435f3b3ec93b15c32ef369382fe6ff395e95e2e10f7ae39227bef51455245ae51490dcf5faa7a710e9af1ad3da8cf17f1f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6defb0bfe7b62d1f39420fcec64247023d16c62e63354208c6bbb6c68685ebb7135ff85bd06516cf94a01819143b781015c1c6d548ca809571be436e6b85b45e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a82a8a0b0236cb60c89b34d880dbbaaa0c49c78d58fb0dc2d1ba284afc01ca82fec327c678051df0067a8ada30eaf03d086044aca3b02421bfc7d33e75a83baf"} 16:14:16 INFO - Running post-run listener: copy_logs_to_upload_dir 16:14:16 INFO - Copying logs to upload dir... 16:14:16 INFO - mkdir: /builds/slave/test/build/upload/logs 16:14:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.294434 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-13 16:14:16.713135) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:16.716990) ========= 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=df17445c3590ff7897617a0e00000225-1465858162.530165-834287790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9b3b890dbba819d48fe1707b8748435f3b3ec93b15c32ef369382fe6ff395e95e2e10f7ae39227bef51455245ae51490dcf5faa7a710e9af1ad3da8cf17f1f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6defb0bfe7b62d1f39420fcec64247023d16c62e63354208c6bbb6c68685ebb7135ff85bd06516cf94a01819143b781015c1c6d548ca809571be436e6b85b45e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a82a8a0b0236cb60c89b34d880dbbaaa0c49c78d58fb0dc2d1ba284afc01ca82fec327c678051df0067a8ada30eaf03d086044aca3b02421bfc7d33e75a83baf"} build_url:https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/aH2rxKB6T9-fBODvh-Sfzg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a9b3b890dbba819d48fe1707b8748435f3b3ec93b15c32ef369382fe6ff395e95e2e10f7ae39227bef51455245ae51490dcf5faa7a710e9af1ad3da8cf17f1f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6defb0bfe7b62d1f39420fcec64247023d16c62e63354208c6bbb6c68685ebb7135ff85bd06516cf94a01819143b781015c1c6d548ca809571be436e6b85b45e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a82a8a0b0236cb60c89b34d880dbbaaa0c49c78d58fb0dc2d1ba284afc01ca82fec327c678051df0067a8ada30eaf03d086044aca3b02421bfc7d33e75a83baf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:16.743450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:16.743837) ========= 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=df17445c3590ff7897617a0e00000225-1465858162.530165-834287790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:16.828658) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 16:14:16.829029) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 16:14:16.829357) ========= ========= Total master_lag: 0.17 =========