builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1465391801.25 results: success (0) buildid: 20160608054229 builduid: 142f3f95e057447a98a4b2b6a06796e5 revision: e69b8135f9e224e049c140dc6fad7e8aa9b18e1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 06:16:41.255001) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 06:16:41.255491) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 06:16:41.255773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 06:16:41.270405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 06:16:41.270741) ========= 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=923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 06:16:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 14.1M=0.001s 2016-06-08 06:16:41 (14.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 06:16:41.381659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 06:16:41.381978) ========= 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=923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015172 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 06:16:41.431456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 06:16:41.431825) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e69b8135f9e224e049c140dc6fad7e8aa9b18e1f --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 e69b8135f9e224e049c140dc6fad7e8aa9b18e1f --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=923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 06:16:41,539 truncating revision to first 12 chars 2016-06-08 06:16:41,539 Setting DEBUG logging. 2016-06-08 06:16:41,539 attempt 1/10 2016-06-08 06:16:41,539 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e69b8135f9e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 06:16:42,233 unpacking tar archive at: fx-team-e69b8135f9e2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.053680 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 06:16:42.517507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 06:16:42.517815) ========= script_repo_revision: e69b8135f9e224e049c140dc6fad7e8aa9b18e1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 06:16:42.518214) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 06:16:42.518492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 06:16:42.528704) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-08 06:16:42.528976) ========= /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=923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:16:42 INFO - MultiFileLogger online at 20160608 06:16:42 in /builds/slave/test 06:16:42 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 06:16:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:16:42 INFO - {'append_to_log': False, 06:16:42 INFO - 'base_work_dir': '/builds/slave/test', 06:16:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:16:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:16:42 INFO - 'branch': 'Fx-Team-Non-PGO', 06:16:42 INFO - 'buildbot_json_path': 'buildprops.json', 06:16:42 INFO - 'config_files': ('talos/linux_config.py',), 06:16:42 INFO - 'default_actions': ('clobber', 06:16:42 INFO - 'read-buildbot-config', 06:16:42 INFO - 'download-and-extract', 06:16:42 INFO - 'populate-webroot', 06:16:42 INFO - 'create-virtualenv', 06:16:42 INFO - 'install', 06:16:42 INFO - 'run-tests'), 06:16:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:16:42 INFO - 'download_minidump_stackwalk': True, 06:16:42 INFO - 'download_symbols': 'ondemand', 06:16:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:16:42 INFO - 'tooltool.py': '/tools/tooltool.py', 06:16:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:16:42 INFO - '/tools/misc-python/virtualenv.py')}, 06:16:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:16:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:16:42 INFO - 'installer_path': 'installer.exe', 06:16:42 INFO - 'log_level': 'info', 06:16:42 INFO - 'log_name': 'talos', 06:16:42 INFO - 'log_to_console': True, 06:16:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:16:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:16:42 INFO - 'opt_config_files': (), 06:16:42 INFO - 'pip_index': False, 06:16:42 INFO - 'sps_profile': False, 06:16:42 INFO - 'sps_profile_interval': 0, 06:16:42 INFO - 'suite': 'dromaeojs', 06:16:42 INFO - 'system_bits': '32', 06:16:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:16:42 INFO - 'title': 'talos-linux64-ix-007', 06:16:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:16:42 INFO - 'use_talos_json': True, 06:16:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:16:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:16:42 INFO - 'work_dir': 'build'} 06:16:42 INFO - ##### 06:16:42 INFO - ##### Running clobber step. 06:16:42 INFO - ##### 06:16:42 INFO - Running pre-action listener: _resource_record_pre_action 06:16:42 INFO - Running main action method: clobber 06:16:42 INFO - rmtree: /builds/slave/test/build 06:16:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:16:43 INFO - Running post-action listener: _resource_record_post_action 06:16:43 INFO - ##### 06:16:43 INFO - ##### Finished clobber step (success) 06:16:43 INFO - ##### 06:16:43 INFO - ##### 06:16:43 INFO - ##### Running read-buildbot-config step. 06:16:43 INFO - ##### 06:16:43 INFO - Running pre-action listener: _resource_record_pre_action 06:16:43 INFO - Running main action method: read_buildbot_config 06:16:43 INFO - Using buildbot properties: 06:16:43 INFO - { 06:16:43 INFO - "project": "", 06:16:43 INFO - "product": "firefox", 06:16:43 INFO - "script_repo_revision": "production", 06:16:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:16:43 INFO - "repository": "", 06:16:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:16:43 INFO - "buildid": "20160608054229", 06:16:43 INFO - "pgo_build": "False", 06:16:43 INFO - "basedir": "/builds/slave/test", 06:16:43 INFO - "buildnumber": 3061, 06:16:43 INFO - "slavename": "talos-linux64-ix-007", 06:16:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:16:43 INFO - "platform": "ubuntu64_hw", 06:16:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:16:43 INFO - "branch": "fx-team", 06:16:43 INFO - "repo_path": "integration/fx-team", 06:16:43 INFO - "revision": "e69b8135f9e224e049c140dc6fad7e8aa9b18e1f", 06:16:43 INFO - "stage_platform": "linux64", 06:16:43 INFO - "builduid": "142f3f95e057447a98a4b2b6a06796e5", 06:16:43 INFO - "slavebuilddir": "test" 06:16:43 INFO - } 06:16:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:16:43 INFO - Running post-action listener: _resource_record_post_action 06:16:43 INFO - ##### 06:16:43 INFO - ##### Finished read-buildbot-config step (success) 06:16:43 INFO - ##### 06:16:43 INFO - ##### 06:16:43 INFO - ##### Running download-and-extract step. 06:16:43 INFO - ##### 06:16:43 INFO - Running pre-action listener: _resource_record_pre_action 06:16:43 INFO - Running main action method: download_and_extract 06:16:43 INFO - mkdir: /builds/slave/test/build/tests 06:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:43 INFO - https://queue.taskcluster.net/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:16:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:16:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:16:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/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 06:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/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 06:16:43 INFO - Downloaded 1361 bytes. 06:16:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:16:43 INFO - Using the following test package requirements: 06:16:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:16:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:16:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:16:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:43 INFO - u'jsshell-linux-x86_64.zip'], 06:16:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:16:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:16:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:16:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:16:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:16:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:16:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:16:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:43 INFO - https://queue.taskcluster.net/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:16:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:16:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:16:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/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 06:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/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 06:16:44 INFO - Downloaded 22878228 bytes. 06:16:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:16:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:16:46 INFO - Return code: 0 06:16:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:46 INFO - https://queue.taskcluster.net/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/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 06:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/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 06:16:47 INFO - Downloaded 22878228 bytes. 06:16:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:16:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:16:48 INFO - Return code: 0 06:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:48 INFO - https://queue.taskcluster.net/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:16:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:16:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:16:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/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 06:16:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/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 06:16:49 INFO - Downloaded 10833369 bytes. 06:16:49 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'] 06:16:49 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 06:16:49 INFO - Return code: 0 06:16: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')]} 06:16:49 INFO - https://queue.taskcluster.net/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:16:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:16:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:16:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/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 06:16:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_7lHl7KQg6-ysIVvf4FJw/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 06:16:51 INFO - Downloaded 55337204 bytes. 06:16:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:16:51 INFO - mkdir: /builds/slave/test/properties 06:16:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:16:51 INFO - Writing to file /builds/slave/test/properties/build_url 06:16:51 INFO - Contents: 06:16:51 INFO - build_url:https://queue.taskcluster.net/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:16:52 INFO - Running post-action listener: _resource_record_post_action 06:16:52 INFO - Running post-action listener: set_extra_try_arguments 06:16:52 INFO - ##### 06:16:52 INFO - ##### Finished download-and-extract step (success) 06:16:52 INFO - ##### 06:16:52 INFO - ##### 06:16:52 INFO - ##### Running populate-webroot step. 06:16:52 INFO - ##### 06:16:52 INFO - Running pre-action listener: _resource_record_pre_action 06:16:52 INFO - Running main action method: populate_webroot 06:16:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:16:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:16:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:16:52 INFO - '--tppagecycles', 06:16:52 INFO - '7'], 06:16:52 INFO - 'tests': ['tsvgm']}}, 06:16:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:16:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:16:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:16:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:16:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:16:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:16:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:52 INFO - 'talos_options': ['--disable-e10s'], 06:16:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:16:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:16:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:52 INFO - 'talos_options': ['--disable-e10s'], 06:16:52 INFO - 'tests': ['damp', 'tps']}, 06:16:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:52 INFO - 'tests': ['damp', 'tps']}, 06:16:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:16:52 INFO - 'tests': ['dromaeo_dom']}, 06:16:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:16:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:16:52 INFO - 'tests': ['a11yr', 06:16:52 INFO - 'ts_paint', 06:16:52 INFO - 'tpaint', 06:16:52 INFO - 'sessionrestore', 06:16:52 INFO - 'sessionrestore_no_auto_restore', 06:16:52 INFO - 'tabpaint']}, 06:16:52 INFO - 'other-e10s': {'tests': ['a11yr', 06:16:52 INFO - 'ts_paint', 06:16:52 INFO - 'tpaint', 06:16:52 INFO - 'sessionrestore', 06:16:52 INFO - 'sessionrestore_no_auto_restore', 06:16:52 INFO - 'tabpaint']}, 06:16:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:16:52 INFO - 'ts_paint', 06:16:52 INFO - 'tpaint', 06:16:52 INFO - 'sessionrestore', 06:16:52 INFO - 'sessionrestore_no_auto_restore', 06:16:52 INFO - 'tabpaint']}, 06:16:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:16:52 INFO - 'ts_paint', 06:16:52 INFO - 'tpaint', 06:16:52 INFO - 'sessionrestore', 06:16:52 INFO - 'sessionrestore_no_auto_restore', 06:16:52 INFO - 'tabpaint']}, 06:16:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:16:52 INFO - 'tests': ['a11yr', 06:16:52 INFO - 'ts_paint', 06:16:52 INFO - 'tpaint', 06:16:52 INFO - 'sessionrestore', 06:16:52 INFO - 'sessionrestore_no_auto_restore', 06:16:52 INFO - 'tabpaint']}, 06:16:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:16:52 INFO - 'tests': ['a11yr', 06:16:52 INFO - 'ts_paint', 06:16:52 INFO - 'tpaint', 06:16:52 INFO - 'sessionrestore', 06:16:52 INFO - 'sessionrestore_no_auto_restore', 06:16:52 INFO - 'tabpaint']}, 06:16:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:16:52 INFO - 'tests': ['tsvgx', 06:16:52 INFO - 'tsvgr_opacity', 06:16:52 INFO - 'tart', 06:16:52 INFO - 'tscrollx', 06:16:52 INFO - 'cart']}, 06:16:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:16:52 INFO - 'tsvgr_opacity', 06:16:52 INFO - 'tart', 06:16:52 INFO - 'tscrollx', 06:16:52 INFO - 'cart']}, 06:16:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:52 INFO - 'talos_options': ['--disable-e10s'], 06:16:52 INFO - 'tests': ['tp5o']}, 06:16:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:52 INFO - 'tests': ['tp5o']}, 06:16:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:52 INFO - 'talos_options': ['--disable-e10s', 06:16:52 INFO - '--xperf_path', 06:16:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:16:52 INFO - 'tests': ['tp5n']}, 06:16:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:52 INFO - 'talos_options': ['--xperf_path', 06:16:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:16:52 INFO - 'tests': ['tp5n']}}, 06:16:52 INFO - 'talos.zip': {'path': '', 06:16:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:16:52 INFO - Running post-action listener: _resource_record_post_action 06:16:52 INFO - ##### 06:16:52 INFO - ##### Finished populate-webroot step (success) 06:16:52 INFO - ##### 06:16:52 INFO - ##### 06:16:52 INFO - ##### Running create-virtualenv step. 06:16:52 INFO - ##### 06:16:52 INFO - Running pre-action listener: _resource_record_pre_action 06:16:52 INFO - Running main action method: create_virtualenv 06:16:52 INFO - Creating virtualenv /builds/slave/test/build/venv 06:16:52 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 06:16:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:16:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:16:52 INFO - Using real prefix '/usr' 06:16:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:16:52 INFO - Installing distribute.............................................................................................................................................................................................done. 06:16:54 INFO - Installing pip.................done. 06:16:54 INFO - Return code: 0 06:16:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:54 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 0x7f6f62915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29601c0>, '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 0x29610c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2961550>, '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': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', '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 06:16:54 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 06:16:54 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 06:16:54 INFO - Using env: {'DISPLAY': ':0', 06:16:54 INFO - 'HOME': '/home/cltbld', 06:16:54 INFO - 'LANG': 'en_US.UTF-8', 06:16:54 INFO - 'LANGUAGE': 'en_US:en', 06:16:54 INFO - 'LOGNAME': 'cltbld', 06:16:54 INFO - 'MAIL': '/var/mail/cltbld', 06:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:54 INFO - 'MOZ_NO_REMOTE': '1', 06:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:54 INFO - 'NO_EM_RESTART': '1', 06:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:54 INFO - 'PWD': '/builds/slave/test', 06:16:54 INFO - 'SHELL': '/bin/bash', 06:16:54 INFO - 'SHLVL': '1', 06:16:54 INFO - 'TERM': 'linux', 06:16:54 INFO - 'TMOUT': '86400', 06:16:54 INFO - 'USER': 'cltbld', 06:16:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', 06:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:54 INFO - '_': '/tools/buildbot/bin/python'} 06:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:54 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 06:16:54 INFO - Cleaning up... 06:16:54 INFO - Return code: 0 06:16:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:54 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 0x7f6f62915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29601c0>, '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 0x29610c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2961550>, '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': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', '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 06:16:54 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 06:16:54 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 06:16:54 INFO - Using env: {'DISPLAY': ':0', 06:16:54 INFO - 'HOME': '/home/cltbld', 06:16:54 INFO - 'LANG': 'en_US.UTF-8', 06:16:54 INFO - 'LANGUAGE': 'en_US:en', 06:16:54 INFO - 'LOGNAME': 'cltbld', 06:16:54 INFO - 'MAIL': '/var/mail/cltbld', 06:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:54 INFO - 'MOZ_NO_REMOTE': '1', 06:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:54 INFO - 'NO_EM_RESTART': '1', 06:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:54 INFO - 'PWD': '/builds/slave/test', 06:16:54 INFO - 'SHELL': '/bin/bash', 06:16:54 INFO - 'SHLVL': '1', 06:16:54 INFO - 'TERM': 'linux', 06:16:54 INFO - 'TMOUT': '86400', 06:16:54 INFO - 'USER': 'cltbld', 06:16:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', 06:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:54 INFO - '_': '/tools/buildbot/bin/python'} 06:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:55 INFO - Downloading/unpacking psutil>=3.1.1 06:16:55 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 06:16:55 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 06:16:55 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 06:16:55 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 06:16:55 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 06:16:55 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 06:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:16:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:16:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:16:57 INFO - Installing collected packages: psutil 06:16:57 INFO - Running setup.py install for psutil 06:16:57 INFO - building 'psutil._psutil_linux' extension 06:16:57 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 06:16:57 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 06:16:57 INFO - building 'psutil._psutil_posix' extension 06:16:57 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 06:16:57 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 06:16:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:16:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:16:57 INFO - Successfully installed psutil 06:16:57 INFO - Cleaning up... 06:16:57 INFO - Return code: 0 06:16:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f62915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29601c0>, '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 0x29610c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2961550>, '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': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', '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 06:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:16:57 INFO - Using env: {'DISPLAY': ':0', 06:16:57 INFO - 'HOME': '/home/cltbld', 06:16:57 INFO - 'LANG': 'en_US.UTF-8', 06:16:57 INFO - 'LANGUAGE': 'en_US:en', 06:16:57 INFO - 'LOGNAME': 'cltbld', 06:16:57 INFO - 'MAIL': '/var/mail/cltbld', 06:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:57 INFO - 'MOZ_NO_REMOTE': '1', 06:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:57 INFO - 'NO_EM_RESTART': '1', 06:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:57 INFO - 'PWD': '/builds/slave/test', 06:16:57 INFO - 'SHELL': '/bin/bash', 06:16:57 INFO - 'SHLVL': '1', 06:16:57 INFO - 'TERM': 'linux', 06:16:57 INFO - 'TMOUT': '86400', 06:16:57 INFO - 'USER': 'cltbld', 06:16:57 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', 06:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:57 INFO - '_': '/tools/buildbot/bin/python'} 06:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:16: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 06:16: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 06:16: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 06:16: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 06:16: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 06:16: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 06:17:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:17:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:17:00 INFO - Installing collected packages: mozsystemmonitor 06:17:00 INFO - Running setup.py install for mozsystemmonitor 06:17:00 INFO - Successfully installed mozsystemmonitor 06:17:00 INFO - Cleaning up... 06:17:01 INFO - Return code: 0 06:17:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:17:01 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')]} 06:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:01 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')]} 06:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:01 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 0x7f6f62915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29601c0>, '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 0x29610c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2961550>, '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': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', '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 06:17:01 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 06:17:01 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 06:17:01 INFO - Using env: {'DISPLAY': ':0', 06:17:01 INFO - 'HOME': '/home/cltbld', 06:17:01 INFO - 'LANG': 'en_US.UTF-8', 06:17:01 INFO - 'LANGUAGE': 'en_US:en', 06:17:01 INFO - 'LOGNAME': 'cltbld', 06:17:01 INFO - 'MAIL': '/var/mail/cltbld', 06:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:01 INFO - 'MOZ_NO_REMOTE': '1', 06:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:01 INFO - 'NO_EM_RESTART': '1', 06:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:01 INFO - 'PWD': '/builds/slave/test', 06:17:01 INFO - 'SHELL': '/bin/bash', 06:17:01 INFO - 'SHLVL': '1', 06:17:01 INFO - 'TERM': 'linux', 06:17:01 INFO - 'TMOUT': '86400', 06:17:01 INFO - 'USER': 'cltbld', 06:17:01 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', 06:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:01 INFO - '_': '/tools/buildbot/bin/python'} 06:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:01 INFO - Downloading/unpacking jsonschema==2.5.1 06:17:01 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 06:17:01 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 06:17:01 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 06:17:01 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 06:17:01 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 06:17:01 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 06:17:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:17:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:17:03 INFO - warning: no files found matching '*.txt' 06:17:03 INFO - no previously-included directories found matching 'build' 06:17:03 INFO - no previously-included directories found matching 'dist' 06:17:03 INFO - no previously-included directories found matching '.git*' 06:17:03 INFO - Installing collected packages: jsonschema, functools32 06:17:03 INFO - Running setup.py install for functools32 06:17:03 INFO - warning: no files found matching '*.txt' 06:17:03 INFO - no previously-included directories found matching 'build' 06:17:03 INFO - no previously-included directories found matching 'dist' 06:17:03 INFO - no previously-included directories found matching '.git*' 06:17:03 INFO - Successfully installed jsonschema functools32 06:17:03 INFO - Cleaning up... 06:17:03 INFO - Return code: 0 06:17:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:03 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 0x7f6f62915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29601c0>, '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 0x29610c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2961550>, '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': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', '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 06:17:03 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 06:17:03 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 06:17:03 INFO - Using env: {'DISPLAY': ':0', 06:17:03 INFO - 'HOME': '/home/cltbld', 06:17:03 INFO - 'LANG': 'en_US.UTF-8', 06:17:03 INFO - 'LANGUAGE': 'en_US:en', 06:17:03 INFO - 'LOGNAME': 'cltbld', 06:17:03 INFO - 'MAIL': '/var/mail/cltbld', 06:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:03 INFO - 'MOZ_NO_REMOTE': '1', 06:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:03 INFO - 'NO_EM_RESTART': '1', 06:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:03 INFO - 'PWD': '/builds/slave/test', 06:17:03 INFO - 'SHELL': '/bin/bash', 06:17:03 INFO - 'SHLVL': '1', 06:17:03 INFO - 'TERM': 'linux', 06:17:03 INFO - 'TMOUT': '86400', 06:17:03 INFO - 'USER': 'cltbld', 06:17:03 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', 06:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:03 INFO - '_': '/tools/buildbot/bin/python'} 06:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:03 INFO - Downloading/unpacking blobuploader==1.2.4 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17: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 06:17:05 INFO - Downloading blobuploader-1.2.4.tar.gz 06:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:17:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:17:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:17:06 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 06:17:06 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 06:17:06 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 06:17:06 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 06:17:06 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 06:17:06 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 06:17:06 INFO - Downloading docopt-0.6.1.tar.gz 06:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:17:06 INFO - Installing collected packages: blobuploader, requests, docopt 06:17:06 INFO - Running setup.py install for blobuploader 06:17:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:17:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:17:06 INFO - Running setup.py install for requests 06:17:06 INFO - Running setup.py install for docopt 06:17:07 INFO - Successfully installed blobuploader requests docopt 06:17:07 INFO - Cleaning up... 06:17:07 INFO - Return code: 0 06:17:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:07 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 0x7f6f62915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29601c0>, '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 0x29610c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2961550>, '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': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', '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 06:17:07 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 06:17:07 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 06:17:07 INFO - Using env: {'DISPLAY': ':0', 06:17:07 INFO - 'HOME': '/home/cltbld', 06:17:07 INFO - 'LANG': 'en_US.UTF-8', 06:17:07 INFO - 'LANGUAGE': 'en_US:en', 06:17:07 INFO - 'LOGNAME': 'cltbld', 06:17:07 INFO - 'MAIL': '/var/mail/cltbld', 06:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:07 INFO - 'MOZ_NO_REMOTE': '1', 06:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:07 INFO - 'NO_EM_RESTART': '1', 06:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:07 INFO - 'PWD': '/builds/slave/test', 06:17:07 INFO - 'SHELL': '/bin/bash', 06:17:07 INFO - 'SHLVL': '1', 06:17:07 INFO - 'TERM': 'linux', 06:17:07 INFO - 'TMOUT': '86400', 06:17:07 INFO - 'USER': 'cltbld', 06:17:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', 06:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:07 INFO - '_': '/tools/buildbot/bin/python'} 06:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:17:07 INFO - Running setup.py (path:/tmp/pip-elWRbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:17:07 INFO - Running setup.py (path:/tmp/pip-ONirhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:17:07 INFO - Running setup.py (path:/tmp/pip-ErKfsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:17:07 INFO - Running setup.py (path:/tmp/pip-LU_Oxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:17:07 INFO - Running setup.py (path:/tmp/pip-invuut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:17:07 INFO - Running setup.py (path:/tmp/pip-I8eEpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:17:07 INFO - Running setup.py (path:/tmp/pip-8Zrk6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:17:07 INFO - Running setup.py (path:/tmp/pip-eIeh26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:17:07 INFO - Running setup.py (path:/tmp/pip-apYzD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:17:07 INFO - Running setup.py (path:/tmp/pip-c9bgct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:17:08 INFO - Running setup.py (path:/tmp/pip-P6Amkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:17:08 INFO - Running setup.py (path:/tmp/pip-1B_s1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:17:08 INFO - Running setup.py (path:/tmp/pip-5kWpQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:17:08 INFO - Running setup.py (path:/tmp/pip-aRg5pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:08 INFO - Running setup.py (path:/tmp/pip-k9VMHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:17:08 INFO - Running setup.py (path:/tmp/pip-uQlVQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:17:08 INFO - Running setup.py (path:/tmp/pip-74ugJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:17:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:17:08 INFO - Running setup.py install for manifestparser 06:17:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:17:08 INFO - Running setup.py install for mozcrash 06:17:08 INFO - Running setup.py install for mozdebug 06:17:08 INFO - Running setup.py install for mozdevice 06:17:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:17:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:17:08 INFO - Running setup.py install for mozfile 06:17:09 INFO - Running setup.py install for mozhttpd 06:17:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:17:09 INFO - Running setup.py install for mozinfo 06:17:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:17:09 INFO - Running setup.py install for mozInstall 06:17:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:17:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:17:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:17:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:17:09 INFO - Running setup.py install for mozleak 06:17:09 INFO - Running setup.py install for mozlog 06:17:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:17:09 INFO - Running setup.py install for moznetwork 06:17:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:17:09 INFO - Running setup.py install for mozprocess 06:17:09 INFO - Running setup.py install for mozprofile 06:17:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:17:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:17:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:17:09 INFO - Running setup.py install for mozrunner 06:17:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:17:10 INFO - Running setup.py install for mozscreenshot 06:17:10 INFO - Running setup.py install for moztest 06:17:10 INFO - Running setup.py install for mozversion 06:17:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:17:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:17:10 INFO - Cleaning up... 06:17:10 INFO - Return code: 0 06:17:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:10 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')]} 06:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:10 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')]} 06:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:10 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 0x7f6f62915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29601c0>, '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 0x29610c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2961550>, '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': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', '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 06:17:10 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 06:17:10 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 06:17:10 INFO - Using env: {'DISPLAY': ':0', 06:17:10 INFO - 'HOME': '/home/cltbld', 06:17:10 INFO - 'LANG': 'en_US.UTF-8', 06:17:10 INFO - 'LANGUAGE': 'en_US:en', 06:17:10 INFO - 'LOGNAME': 'cltbld', 06:17:10 INFO - 'MAIL': '/var/mail/cltbld', 06:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:10 INFO - 'MOZ_NO_REMOTE': '1', 06:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:10 INFO - 'NO_EM_RESTART': '1', 06:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:10 INFO - 'PWD': '/builds/slave/test', 06:17:10 INFO - 'SHELL': '/bin/bash', 06:17:10 INFO - 'SHLVL': '1', 06:17:10 INFO - 'TERM': 'linux', 06:17:10 INFO - 'TMOUT': '86400', 06:17:10 INFO - 'USER': 'cltbld', 06:17:10 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', 06:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:10 INFO - '_': '/tools/buildbot/bin/python'} 06:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:17:10 INFO - Running setup.py (path:/tmp/pip-Irms6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:17:10 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)) 06:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:17:10 INFO - Running setup.py (path:/tmp/pip-S8LUYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:17:10 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)) 06:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:17:10 INFO - Running setup.py (path:/tmp/pip-BNp5bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:17:10 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)) 06:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:17:10 INFO - Running setup.py (path:/tmp/pip-SkESVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:17:10 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)) 06:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:17:10 INFO - Running setup.py (path:/tmp/pip-9Ugv1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:17:10 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)) 06:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:17:10 INFO - Running setup.py (path:/tmp/pip-KRpZTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:17:10 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)) 06:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:17:11 INFO - Running setup.py (path:/tmp/pip-EDYBsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:17:11 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)) 06:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:17:11 INFO - Running setup.py (path:/tmp/pip-orUsoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:17:11 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)) 06:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:17:11 INFO - Running setup.py (path:/tmp/pip-jl78eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:17:11 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)) 06:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:17:11 INFO - Running setup.py (path:/tmp/pip-016zHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:17:11 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)) 06:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:17:11 INFO - Running setup.py (path:/tmp/pip-cqqosl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:17:11 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)) 06:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:17:11 INFO - Running setup.py (path:/tmp/pip-Biz55H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:17:11 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)) 06:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:17:11 INFO - Running setup.py (path:/tmp/pip-GoVfxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:17:11 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)) 06:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:17:11 INFO - Running setup.py (path:/tmp/pip-C5Cw1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:17:11 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)) 06:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:11 INFO - Running setup.py (path:/tmp/pip-btW_JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:17:11 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)) 06:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:17:11 INFO - Running setup.py (path:/tmp/pip-u8O3nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:17:11 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)) 06:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:17:11 INFO - Running setup.py (path:/tmp/pip-o25_UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:17:11 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)) 06:17:11 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)) 06:17:11 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)) 06:17:11 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)) 06:17:11 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)) 06:17:11 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)) 06:17:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:17:11 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 06:17:11 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 06:17:11 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 06:17:11 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 06:17:11 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 06:17:11 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 06:17:13 INFO - Downloading blessings-1.6.tar.gz 06:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:17:13 INFO - Installing collected packages: blessings 06:17:13 INFO - Running setup.py install for blessings 06:17:13 INFO - Successfully installed blessings 06:17:13 INFO - Cleaning up... 06:17:13 INFO - Return code: 0 06:17:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:17:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:17:14 INFO - Reading from file tmpfile_stdout 06:17:14 INFO - Current package versions: 06:17:14 INFO - argparse == 1.2.1 06:17:14 INFO - blessings == 1.6 06:17:14 INFO - blobuploader == 1.2.4 06:17:14 INFO - docopt == 0.6.1 06:17:14 INFO - functools32 == 3.2.3-2 06:17:14 INFO - jsonschema == 2.5.1 06:17:14 INFO - manifestparser == 1.1 06:17:14 INFO - mozInstall == 1.12 06:17:14 INFO - mozcrash == 0.17 06:17:14 INFO - mozdebug == 0.1 06:17:14 INFO - mozdevice == 0.48 06:17:14 INFO - mozfile == 1.2 06:17:14 INFO - mozhttpd == 0.7 06:17:14 INFO - mozinfo == 0.9 06:17:14 INFO - mozleak == 0.1 06:17:14 INFO - mozlog == 3.2 06:17:14 INFO - moznetwork == 0.27 06:17:14 INFO - mozprocess == 0.22 06:17:14 INFO - mozprofile == 0.28 06:17:14 INFO - mozrunner == 6.11 06:17:14 INFO - mozscreenshot == 0.1 06:17:14 INFO - mozsystemmonitor == 0.3 06:17:14 INFO - moztest == 0.7 06:17:14 INFO - mozversion == 1.4 06:17:14 INFO - psutil == 3.1.1 06:17:14 INFO - requests == 1.2.3 06:17:14 INFO - wsgiref == 0.1.2 06:17:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:14 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 0x7f6f62915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29601c0>, '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 0x29610c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2961550>, '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': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', '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 06:17:14 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 06:17:14 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 06:17:14 INFO - Using env: {'DISPLAY': ':0', 06:17:14 INFO - 'HOME': '/home/cltbld', 06:17:14 INFO - 'LANG': 'en_US.UTF-8', 06:17:14 INFO - 'LANGUAGE': 'en_US:en', 06:17:14 INFO - 'LOGNAME': 'cltbld', 06:17:14 INFO - 'MAIL': '/var/mail/cltbld', 06:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:14 INFO - 'MOZ_NO_REMOTE': '1', 06:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:14 INFO - 'NO_EM_RESTART': '1', 06:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:14 INFO - 'PWD': '/builds/slave/test', 06:17:14 INFO - 'SHELL': '/bin/bash', 06:17:14 INFO - 'SHLVL': '1', 06:17:14 INFO - 'TERM': 'linux', 06:17:14 INFO - 'TMOUT': '86400', 06:17:14 INFO - 'USER': 'cltbld', 06:17:14 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', 06:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:14 INFO - '_': '/tools/buildbot/bin/python'} 06:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:14 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)) 06:17:14 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)) 06:17:14 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)) 06:17:14 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)) 06:17:14 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)) 06:17:14 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)) 06:17:14 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)) 06:17:14 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)) 06:17:14 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)) 06:17:14 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)) 06:17:14 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)) 06:17:14 INFO - Cleaning up... 06:17:14 INFO - Return code: 0 06:17:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f62915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29601c0>, '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 0x29610c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2961550>, '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': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', '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 06:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:17:14 INFO - Using env: {'DISPLAY': ':0', 06:17:14 INFO - 'HOME': '/home/cltbld', 06:17:14 INFO - 'LANG': 'en_US.UTF-8', 06:17:14 INFO - 'LANGUAGE': 'en_US:en', 06:17:14 INFO - 'LOGNAME': 'cltbld', 06:17:14 INFO - 'MAIL': '/var/mail/cltbld', 06:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:14 INFO - 'MOZ_NO_REMOTE': '1', 06:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:14 INFO - 'NO_EM_RESTART': '1', 06:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:14 INFO - 'PWD': '/builds/slave/test', 06:17:14 INFO - 'SHELL': '/bin/bash', 06:17:14 INFO - 'SHLVL': '1', 06:17:14 INFO - 'TERM': 'linux', 06:17:14 INFO - 'TMOUT': '86400', 06:17:14 INFO - 'USER': 'cltbld', 06:17:14 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', 06:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:14 INFO - '_': '/tools/buildbot/bin/python'} 06:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:17:14 INFO - Cleaning up... 06:17:14 INFO - Return code: 0 06:17:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:17:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f62915f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29601c0>, '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 0x29610c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2961550>, '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': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', '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 06:17:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:17:14 INFO - Using env: {'DISPLAY': ':0', 06:17:14 INFO - 'HOME': '/home/cltbld', 06:17:14 INFO - 'LANG': 'en_US.UTF-8', 06:17:14 INFO - 'LANGUAGE': 'en_US:en', 06:17:14 INFO - 'LOGNAME': 'cltbld', 06:17:14 INFO - 'MAIL': '/var/mail/cltbld', 06:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:14 INFO - 'MOZ_NO_REMOTE': '1', 06:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:14 INFO - 'NO_EM_RESTART': '1', 06:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:14 INFO - 'PWD': '/builds/slave/test', 06:17:14 INFO - 'SHELL': '/bin/bash', 06:17:14 INFO - 'SHLVL': '1', 06:17:14 INFO - 'TERM': 'linux', 06:17:14 INFO - 'TMOUT': '86400', 06:17:14 INFO - 'USER': 'cltbld', 06:17:14 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', 06:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:14 INFO - '_': '/tools/buildbot/bin/python'} 06:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:17:14 INFO - Downloading/unpacking flake8 06:17:14 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 06:17:14 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 06:17:14 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 06:17:14 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 06:17:14 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 06:17:14 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 06:17:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:17:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:17:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:17:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:17:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:17:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:17:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:17:17 INFO - no previously-included directories found matching 'docs/_build' 06:17:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:17:17 INFO - Running setup.py install for pep8 06:17:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:17:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:17:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:17:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:17:17 INFO - no previously-included directories found matching 'docs/_build' 06:17:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:17:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:17:17 INFO - Cleaning up... 06:17:17 INFO - Return code: 0 06:17:17 INFO - Running post-action listener: _resource_record_post_action 06:17:17 INFO - Running post-action listener: _start_resource_monitoring 06:17:17 INFO - Starting resource monitoring. 06:17:17 INFO - ##### 06:17:17 INFO - ##### Finished create-virtualenv step (success) 06:17:17 INFO - ##### 06:17:17 INFO - ##### 06:17:17 INFO - ##### Running install step. 06:17:17 INFO - ##### 06:17:17 INFO - Running pre-action listener: _resource_record_pre_action 06:17:17 INFO - Running main action method: install 06:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:17:17 INFO - Reading from file tmpfile_stdout 06:17:17 INFO - Detecting whether we're running mozinstall >=1.0... 06:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:17:17 INFO - Reading from file tmpfile_stdout 06:17:17 INFO - Output received: 06:17:17 INFO - Usage: mozinstall [options] installer 06:17:17 INFO - Options: 06:17:17 INFO - -h, --help show this help message and exit 06:17:17 INFO - -d DEST, --destination=DEST 06:17:17 INFO - Directory to install application into. [default: 06:17:17 INFO - "/builds/slave/test"] 06:17:17 INFO - --app=APP Application being installed. [default: firefox] 06:17:17 INFO - mkdir: /builds/slave/test/build/application 06:17:17 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'] 06:17:17 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 06:17:33 INFO - Reading from file tmpfile_stdout 06:17:33 INFO - Output received: 06:17:33 INFO - /builds/slave/test/build/application/firefox/firefox 06:17:33 INFO - Running post-action listener: _resource_record_post_action 06:17:33 INFO - ##### 06:17:33 INFO - ##### Finished install step (success) 06:17:33 INFO - ##### 06:17:33 INFO - ##### 06:17:33 INFO - ##### Running run-tests step. 06:17:33 INFO - ##### 06:17:33 INFO - Running pre-action listener: _resource_record_pre_action 06:17:33 INFO - Running main action method: run_tests 06:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:17:33 INFO - Python 2.7.3 06:17:33 INFO - Return code: 0 06:17:33 INFO - grabbing minidump binary from tooltool 06:17:33 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')]} 06:17:33 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 0x29601c0>, '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 0x29610c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2961550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:17:33 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 06:17:33 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 06:17:33 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 06:17:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:17:34 INFO - Return code: 0 06:17:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:17:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:17:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:17:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:17:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:17:34 INFO - Return code: 0 06:17:34 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/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 06:17:34 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/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 06:17:34 INFO - Using env: {'DISPLAY': ':0', 06:17:34 INFO - 'HOME': '/home/cltbld', 06:17:34 INFO - 'LANG': 'en_US.UTF-8', 06:17:34 INFO - 'LANGUAGE': 'en_US:en', 06:17:34 INFO - 'LOGNAME': 'cltbld', 06:17:34 INFO - 'MAIL': '/var/mail/cltbld', 06:17:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:17:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:17:34 INFO - 'MOZ_NO_REMOTE': '1', 06:17:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:17:34 INFO - 'NO_EM_RESTART': '1', 06:17:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:17:34 INFO - 'PWD': '/builds/slave/test', 06:17:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:17:34 INFO - 'SHELL': '/bin/bash', 06:17:34 INFO - 'SHLVL': '1', 06:17:34 INFO - 'TERM': 'linux', 06:17:34 INFO - 'TMOUT': '86400', 06:17:34 INFO - 'USER': 'cltbld', 06:17:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692', 06:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:17:34 INFO - '_': '/tools/buildbot/bin/python'} 06:17:34 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/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 06:17:35 INFO - mozversion application_buildid: 20160608054229 06:17:35 INFO - mozversion application_changeset: e69b8135f9e224e049c140dc6fad7e8aa9b18e1f 06:17:35 INFO - mozversion application_display_name: Nightly 06:17:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:17:35 INFO - mozversion application_name: Firefox 06:17:35 INFO - mozversion application_remotingname: firefox 06:17:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:17:35 INFO - mozversion application_vendor: Mozilla 06:17:35 INFO - mozversion application_version: 50.0a1 06:17:35 INFO - mozversion platform_buildid: 20160608054229 06:17:35 INFO - mozversion platform_changeset: e69b8135f9e224e049c140dc6fad7e8aa9b18e1f 06:17:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:17:35 INFO - mozversion platform_version: 50.0a1 06:17:35 INFO - using testdate: 1465391855 06:17:35 INFO - actual date: 1465391855 06:17:35 INFO - starting webserver on 'localhost:43559' 06:17:35 INFO - SUITE-START | Running 2 tests 06:17:35 INFO - TEST-START | dromaeo_css 06:17:35 INFO - operating with platform_type : linux_ 06:17:35 INFO - Initialising browser for dromaeo_css test... 06:17:35 INFO - TEST-INFO | started process 7049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9k6zjp/profile http://localhost:43559/getInfo.html) 06:17:39 INFO - PROCESS | 7049 | __metrics Screen width/height:1600/1200 06:17:39 INFO - PROCESS | 7049 | colorDepth:24 06:17:39 INFO - PROCESS | 7049 | Browser inner width/height: 1024/697 06:17:39 INFO - PROCESS | 7049 | __metrics 06:17:40 ERROR - PROCESS | 7049 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:17:40 INFO - PROCESS | 7049 | console.error: PushService: 06:17:40 INFO - PROCESS | 7049 | stateChangeProcessEnqueue: Error transitioning state 06:17:40 INFO - PROCESS | 7049 | UnknownError 06:17:41 INFO - TEST-INFO | 7049: exit 0 06:17:41 INFO - Browser initialized. 06:17:41 INFO - Running cycle 1/1 for dromaeo_css test... 06:17:41 INFO - TEST-INFO | started process 7131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9k6zjp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:52 INFO - PROCESS | 7131 | RSS: Main: 158162944 06:17:52 INFO - PROCESS | 7131 | 06:18:44 INFO - PROCESS | 7131 | 1465391924243 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] 06:20:57 INFO - PROCESS | 7131 | Cycle 1(1): loaded http://localhost:43559/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43559/tests/dromaeo/cssquery-ext.html) 06:20:58 INFO - PROCESS | 7131 | RSS: Main: 261500928 06:20:58 INFO - PROCESS | 7131 | 06:24:01 INFO - PROCESS | 7131 | Cycle 1(1): loaded http://localhost:43559/tests/dromaeo/cssquery-ext.html (next: http://localhost:43559/tests/dromaeo/cssquery-jquery.html) 06:24:01 INFO - PROCESS | 7131 | RSS: Main: 238686208 06:24:01 INFO - PROCESS | 7131 | 06:27:03 INFO - PROCESS | 7131 | Cycle 1(1): loaded http://localhost:43559/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43559/tests/dromaeo/cssquery-mootools.html) 06:27:04 INFO - PROCESS | 7131 | RSS: Main: 240607232 06:27:04 INFO - PROCESS | 7131 | 06:30:06 INFO - PROCESS | 7131 | Cycle 1(1): loaded http://localhost:43559/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43559/tests/dromaeo/cssquery-prototype.html) 06:30:07 INFO - PROCESS | 7131 | RSS: Main: 240947200 06:30:07 INFO - PROCESS | 7131 | 06:33:10 INFO - PROCESS | 7131 | Cycle 1(1): loaded http://localhost:43559/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43559/tests/dromaeo/cssquery-yui.html) 06:33:10 INFO - PROCESS | 7131 | RSS: Main: 208490496 06:33:10 INFO - PROCESS | 7131 | 06:36:13 INFO - PROCESS | 7131 | Cycle 1(1): loaded http://localhost:43559/tests/dromaeo/cssquery-yui.html (next: http://localhost:43559/tests/dromaeo/cssquery-dojo.html) 06:36:13 INFO - PROCESS | 7131 | RSS: Main: 274677760 06:36:13 INFO - PROCESS | 7131 | 06:36:13 INFO - PROCESS | 7131 | __start_tp_report 06:36:13 INFO - PROCESS | 7131 | _x_x_mozilla_page_load 06:36:13 INFO - PROCESS | 7131 | _x_x_mozilla_page_load_details 06:36:13 INFO - PROCESS | 7131 | |i|pagename|runs| 06:36:13 INFO - PROCESS | 7131 | |0;dojo.html;2673.906413275535;2674.251209661293;2708.1740069278867;2714.647095877536;2725.250556097073;4631.374764406804;4686.367340409044;4723.149833030053;4753.287006948955;4812.109759694455;4705.411823522059;4730.053989202156;4744.24092145256;4764.690295130814;4783.665143439961;4263.360495925621;4295.1839150561445;4322.654187664987;4344.608985191332;4368.49762277339;4379.474463064436;4441.555844415549;4464.866054018385;4474;4510.97744511277;4397.9120417591785;4442.689011769177;4443.844465443694;4455.665825063117;4476.910461790762;4247.766372849523;4292.205941900727;4299.871003869889;4312.913741725148;4313.590208930146;4263.360495925605;4289.227938970984;4330.372096046056;4342.196693611692;4381.802818873159;4663.673542852001;4679.274712419547;4688.085823264465;4689.62483001359;4698.248280275174;4933.80264789408;4993.7503124843615;5044.621653376012;5049.267856160836;5118.2578526113875;5078.669886457368;5121.129408000649;5127.256547800585;5135.64050516464;5142.305788718512;4655.6973796703105;4719.315699223594;4738.028704115648;4745.335653008581;4779.522047795263;5147.819826306136;5224.634275600747;5234.13636749932;5234.895302093937;5296.947030529723;5020.548150666457;5059.038782631288;5073.949260507421;5075.289459475676;5081.872953176126;4918.754062296871;5060.342155519759;5109.846704598868;5112.948870511322;5136.743162841843;5031;5058.342415485963;5100.7959681613065;5110.156824124052;5117.692938423706;5032.245163225545;5037.143685573461;5044.419891712427;5046.394432668103;5096.362954630671;4138.110306284163;4247.065645557972;4256.936145957813;4258.382534532538;4307.009387840814;3674.6876515495946;3697.8520859165333;3700;3721.813909304524;3761;4451.243288640939;4460.9107817844115;4461.7992190351515;4485.0805584855025;4502.774861256924;4977.477364876636;5113.411957624847;5124.128898087334;5127.07712611726;5180.7150606717;4379.299312110047;4394.252976993918;4439.223135951195;4453.599176074169;4456.309272062771;4509.616682582017;4539.16025535277;4546.61353784932;4555.453345598549;4580.587747102777;4691.179043667276;4836.443808961944;4837.733924634179;4839;4865.878353041202;5043.798248070036;5062.190049592047;5115.590752739847;5136.768845401891;5136.9743151284;4827.227643577011;4848.830290939942;4862.222044472867;4871.5128487151005;4914.852554423373;4897.853064408074;5022.573081288131;5056.494350564914;5071.39143302806;5125.5899528036925;5097.209932460326;5158.329417175743;5178.352705911761;5179.326687530597;5227.294315267391;4996.450390457119;5015.824446144367;5019.799208031638;5020.698758074527;5065.924011139762;4816.975915120543;4825.252085926687;4862.05189987949;4998.4501704813165;5013.899722005613;4823.710577365369;4849.345338379415;4850.1997170466475;4851.981083972405;4853.635977301646;4911.63162762787;4911.950880491149;4913.238448040559;4924.359833221658;4957.256411538154;4692.741899195577;4782.0914026334885;4840.540148685869;4852.684575502581;4875.561199492063 06:36:13 INFO - PROCESS | 7131 | |1;ext.html;546.7184400033983;591.0779184472224;591.5179129009854;593.9940600593993;605.0410099991515;28205.435891282163;30526.694733052664;30572.388552228942;30575.847120764363;30594.694053059462;31000.37999240014;42336.57663423365;43110.78444607781;43137.137257254835;46447.30329045059;7731.729389471356;7901.051873775155;7907.48601340911;7908.644111014989;7910.3276221520955;7792.571408572526;7920.36637069036;7923.12845586985;7928.524288542706;7931.206879312081;7903.3282171015535;7934.642941067637;7961.442699011071;7965.24330188634;7965.721199757981;7854.410919181056;7911.802204944865;7917.920820791834;7927.286544210991;7929.167437419045;7806.102298235719;7890.053193616745;7892.80267993299;7893.407994400385;7893.447458677895;39289.60710392888;39767.80116099401;39801;39862.20275594501;39881.40177897334;2915.7230063143966;3035.741961933238;3058.480058390079;3090.072978106559;3349.514320423525;29637.70362296371;30284.84857575698;30293.394132117453;30599.847000764854;31101.377972440423;3333.96666033339;3337.2991671748964;3342.398368293706;3356.194513316811;3421.828908554587;250907;252206;252531;252686.99999999817;253224;56990.43009569934;57478.7126064367;57540;57576.71211643999;57598.71200644054;31511.527327090113;32221.35557288841;32288;33844.15389615279;60636.696816516516;13907.026508144332;14063.367148478139;14068.71862562743;14104.435822566982;14108.294585270696;11150.107991360834;11167.497462614201;11362.886371136348;11367.829482557769;11394.544218231344;18969.24123035063;19049.333273335644;19106.52233694169;19126.2349506021;19154.52113697169;6481.319461456479;6758.189017317954;6767.52627316093;6795.25252222265;7104.751333703295;757.4849102610168;857.9871301930476;991.9950400248097;1015.0864222200079;1021.9591216351412;28074.438511229662;28174.577381339295;28774.136775896757;29356.412871742872;29374.265643359086;950.2208189284859;959.8080383923243;980.9411435313762;1001.2090448545567;1010.8981210480612;14609.342579583945;14965.551033469013;15111.168885711171;15366.231688415535;15413.306401211748;364216;370183;370703;370803;374618;50633.49366506288;51048.744756275984;51194.48805511972;51627;51673.48326516687;1104.7238190452388;1187.5808408951393;1232.2175418609067;1238.8637249902504;1253.5048655780915;28366.716332836408;29216.41567168687;29368.412631746818;29860.850695746383;29993.55009674813;42255.366169508095;42904.14191716086;42906;43053.56946430621;43062.78468607637;294981;296792;297462;298042;298266;22382.32853014412;24502.264932051356;25580.616290755283;25631.871840640677;25908.740912590634;42948.78525607352;43326.56673433226;43374;44036;44037.33943990907;36558;37234.441483378316;37459.81270093632;37471.939043352875;38048.23903521859;36545.45181822222;37047.073823154635;37144.25711485809;37217;37264.25471490609;36118.27763444664;36893.26213475769;37201.81399092987;37639.81180094082;37750.2449951005;32081.679183208802;32915.83542082274;33467;33766.15584610404;33807.66192338045;25292.241232763048;25358.873205633852;25434.23697289084;25548.10581629634;25868.611970820075 06:36:13 INFO - PROCESS | 7131 | |2;jquery.html;361.70521025364326;366.15053076861676;367.5901369972481;372.7614326830828;388.77256804769206;15399.384024639015;17097.31610735572;17140.400085996993;17535.473935781916;17635.20641571129;16214.675706485863;16356.672866542693;17013;17017.82982170181;17042.74435883463;4971.651984361096;5145.202493613496;5149.588032957355;5151.227315902607;5153.716545589991;3703.388940824774;3920.0591857954173;5052.418971818232;5686.971565142168;5977.88044239115;5996.580239383245;6027.246594175728;6035.728392222339;6041.761438905014;6044.909326360108;5920.259967504062;5942.910856337158;6006.519478441736;6007.429294217064;6075.544334174911;3395.558577384949;4931.9753401232765;5244.973775131138;5246.81636142737;5301.469853014706;19490.220391184335;20153.193872245094;20224.797752022587;20225.089870955842;20271.493212669655;2247.6403775395856;2465.235776909164;2483.205374280231;2485.5277497275642;2498.088197807805;12333.136680432284;12943.870561294454;13003.284819334933;13178.209307441584;13425;1723.4484964811265;1723.5087999919963;1778.6353797471488;1823.7446757453968;1856.5982683074192;65695;66026.66986665085;66039.3396066038;66330;67978;8813.118688131264;8892.911070889208;8967.641294348283;9005.189532942066;9055.864162037575;11581.07351411885;11646.53413863453;11661.88338116625;11688.649340519798;11726.120540959462;7103.360697537247;7148.676680078996;7193.5324203926575;7225.385842203472;7233.095863017123;6897.655117244118;6980.895286570705;7016.26329235423;7073.964630176816;7207.7837664869085;5822.505087067647;5886.146508756292;5968.134620480006;6000.399960003964;6002.189704389852;1578.2424436270655;1695.508302592259;1708.42767672831;1718.269735362491;1729.6540691861678;689.1592257445908;894.5974311559825;897.3001059173855;981.2003217377815;986.7138529826414;16343.509694709177;17034.74447883283;17218.827811721723;17219.913900430416;17316.39392621252;833.4957350802798;849.5582297205542;856.1652388920752;902.6479672927563;970.0986067308155;8919.866202006975;9297.814043719223;9349.90650093504;9413.246940244764;9530.618775248913;401860;402083;402095;403105;409208;76671;80639;80859.94926817581;80959.59520202361;81036;954.7613096725958;955.2930831184873;955.6511873166244;956.4691596164057;960.0543464687278;13745;14585.343659535134;14673.486427974969;14742.63143421423;14925.701485970438;26358.73641263563;31545.36909261848;34130.976070717916;34619.364966678135;34709.65290347064;49280.75359623179;50139;50695.74652126716;50711.23933140932;50736.49263507318;7207.1711753146965;7329.9267007329245;7431.442641801778;7462.365698915653;7465.253474652709;10522.210834187314;11183;11289.491972861406;11390.088792896382;11417.37204453763;8138;9525.904740952501;9649.855252171083;9671.516424178904;9917.404955702681;9932.205423566242;9967.40195588267;10172.542235599267;10192.439415832201;10305.484725763532;9553.61785528599;9782.266330025133;9803.137403893237;9983;10061.14480269156;7195.884637881137;7220.4945653805835;7337.26627337262;7376.815579610553;7874.763757087297;7746.8450630985935;9736.707898763048;9838.114569688476;9910.851337229804;10189.796204076025 06:36:13 INFO - PROCESS | 7131 | |3;mootools.html;1224.6999485126146;1389.8332200135983;1457.9198144102074;1528.8547587979144;1739.7216445368745;6735.393814556689;7610.771676849697;7845.725399611015;7854.803629909248;8076.434649574532;7742.14836367999;7909.92090079099;7913.248241417071;7921.7227397041115;8003.439759216857;2116.0795054151417;2124.840636952227;2141.625215587274;2146.420466474051;2147.6456384696507;2138.2302371146375;2156.148321413049;2208.4920468292303;2213.845030847833;2215.102883332253;2145.8283337332978;2163.405063607505;2172.2831465616387;2176.107795803721;2182.5416662500893;2092.5605622819226;2095.8113769760716;2101.1805395895612;2101.8528702990798;2104.936851894438;2069.7826728193622;2131.4777879419485;2137.5297434564372;2138.8823614701187;2140.6360918643713;7740.109887362969;7895.60521973899;7967.282944534962;7969.521828690297;7992.560409177493;4717.905641887143;4819.349387832633;4836.322914791932;4838.03239352131;4844.394450693663;2819.1401622505127;2913.067818298124;2952.2324195709057;2962.6296712910885;2972.038454619962;917.5733284022895;918.196577994255;941.5245301122889;945.7541039329824;969.7139343893568;10866.239363244576;10970;11000.449977501094;11005.944970275177;11019.944900275448;4049.7367671101283;4095.7917414362237;4161.417401563784;4216.156768646283;4234.87295381139;8673.04596494385;8762.561871906379;8768.561571921378;8780.648774049094;8782.385233033627;4639.257718764981;4675.7895894684825;4701.3653156824075;4705.670603057753;4710.740909250024;3608.0979755061235;3928.371460566296;4257.40396344512;4339.804708788049;4404.2512772828695;3352.2625022495013;3380.154961259685;3417.658234176612;3443.896683099511;3454.6199918008997;960.558143254097;978.2320878110648;981.3130808434124;995.6515219673201;1007.8740157480315;812.308916010035;815.9021709532863;829.6017911402561;830.9169083091642;849.6601359456267;5063.721495317719;5307.097793375136;5316.0696878046965;5317.813876514303;5373.196427775374;393.41577757030785;409.6190542795229;417.230210262066;421.8734379686082;422.2315385997517;3568.1436455250555;3600.261946301002;3608.116011577128;3610.2598967211657;3673.9816300918324;9470.242380609534;9742.805143897082;9824.754381140387;9841.163501102343;9888.851667224997;9689.079537443931;9735.56189971453;9751;9764.707058788248;9786.217102631916;7329.413646908234;7371.741989030465;7451.478396512192;7592.506487078323;7603;5244;5248.501392367719;5277.445868183939;5430.266913966564;5464.18037294409;8964.596593153194;9162.496062716615;9244.491552964651;9252.907470925205;9261.76845578839;8657.783555411164;8970.775730606787;9019.909800901907;9267.44395336282;9316.44101353921;5960.612560183574;6269.529785266032;6405.295417504164;6431.067495213074;6557.311482294481;7678.923210768045;7710.344620707303;7760.223977602194;7769.72805951789;7781.766547003599;6708.731650733916;6740.561863478858;6891.276415976451;6975.337342952412;7020.297970202939;6840.863182736218;6891.241963384124;6936.410405115622;6996.0905082341005;7064.152301723826;6380.968095159495;6501.739930402731;6538.346165383424;6560.639164845979;6570.441512471493;4642.698224615389;4664.55686709762;4685.320628508779;4733.431988161443;4770.952290477051;4577.771111444348;4620.930686039779;4653.813847446199;4723.0081682846985;4791.448983366958 06:36:13 INFO - PROCESS | 7131 | |4;prototype.html;293.31657238633983;293.69015688448684;294.6537818063775;298.91331513860956;302.50691373061903;4732.763361831908;4785.808567657289;4806.182948898691;4813.9759301203485;4825.300331451937;4703.764811759407;4713.43438787346;4736.123817093831;4750.596199323062;4752.619790416767;3563.9109022274392;3659.5242618459565;3665.332273815421;3683.447482877563;3697.5747789004204;3589.3898037333715;3695.5011073505;3789.696824254053;3794.1273507093383;3800.429935509682;3713.220223753015;3730.9626903730887;3735.701143908481;3750.268697603968;3775;3646.4165733482514;3730.459083432914;3730.9813450932843;3741.4948981887505;3743.401055831054;3301.207710149547;3318.5851768528933;3319.3029463812627;3320.6717313074964;3329.467285234351;4504.639628829718;4509.301058335963;4520.276755719069;4522.412086428776;4549.886252843672;4252.553481884389;4271.209826182167;4277.080427708027;4293.3130699088;4301.687700470651;4719.905601887977;4915.877103072416;4930.753462326905;4939.53074457926;4941.861917682261;3575.982120089409;3577.6601222883783;3603.6036036036016;3604.0088975531676;3608.2422691234874;5172.948270517322;5188.948110518884;5204.661696989683;5205.687658740488;5213.973930130363;3424;3627.0207044097947;3647.927041459156;3650.452432135148;3652.8538858445363;3646.252518233756;3668.8899333020054;3672.926541469209;3676.540432445944;3680.4847321375028;4135.29699951003;4136.8003279048735;4137.751734895855;4163.917381480836;4168.416421700964;4966.925496117561;4973.6269779765935;4981.750912454435;4986.376702912136;5008.445692696678;1213.538855235005;1251.8059700746398;1258.2261908925946;1258.2576279994664;1262.1291308996763;777.4557809533236;800.4636893281399;800.8598495263423;808.7452452477451;808.8018435483226;4253.659707223414;4340.782960851945;4442.42248507692;4469.262571675702;4480.932786008212;5154;5156.226566015052;5157.535821775983;5166.870828229249;5168.689878607295;4430.712003719748;4433.334999750064;4447.777611119431;4457.331400289982;4461.152381047591;2566.2371326736397;2694.5958106283824;2702.945941081207;2713.4668912065017;2732.893178262807;4874.317595536628;4879.975600122048;4886.53577910098;4888.437829649564;4890.486498917634;5090.821821236313;5216.087184742731;5222.582193424517;5260.763265653055;5289.074411977888;4848.781804818721;4868.440129385166;4885.218365061573;4886.267059941038;4901.950980490221;5104.821331253537;5125.128728116304;5187.636865419385;5190.948090519198;5198.558122559625;4775.021120670323;5048.873778155576;5071.163258062378;5088.135017047037;5101.591872650105;4838.443578988321;4846.588040016638;4878.341423907727;4878.90242195147;4881.243407271879;3566.6611671892165;3567.1795487038644;3589.802560859178;3604.189057462155;3614.6746792788776;5151.819686311111;5164.354455693038;5183.637145399785;5187.144121219956;5204.245384419314;4760.238361862085;5056.165732654218;5060.3168572242275;5062.240663900445;5090.312807771052;4966.553010229097;5000.549950504472;5013.799448022039;5049.57078648319;5053.166227572557;4840.7337596432535;4933.432655244693;4958.082754690394;4959.380077490314;4975.427825799935;4775.928361074517;4944.703317800943;5046.21783623539;5064.772085256099;5065.164247899203;4950.306957025947;4962.560857351472;4967.850964471072;4980.186194799927;4992.326035985241 06:36:13 INFO - PROCESS | 7131 | |5;yui.html;608.7382425557008;613.2457077794313;625.9843503912405;697.0624510034003;701.8631366883458;12601.621951341464;12615.116941814076;12754.55359062433;12788.424520896559;12841.42213600388;12229.38853057348;12327.824378372441;12566.18319809214;13331.40008699611;13332.600021999331;787.2678409079568;789;798.7683571764211;799.312591171592;799.6561478564215;634.5494698763883;787.9763607091796;794.1859593916254;796.760971708488;818.6275244763618;832.6919039955195;835.6364981233183;837.7151768398743;846.5217152308957;847.7202523167371;659.320899473543;835.3442547600135;837.4347315562002;837.5016864965397;838.7064527415356;596.5019208960523;601.9428154325332;608.8782243551308;613.2426453330133;613.3743581546842;12841.1011229214;12854.55009074678;12864;12866.678333041655;12870.871291287154;12391.876081239163;12978.935105324414;13003.219806811527;13078.149920255153;13198.73602527944;11750.471228794639;11982.880171198263;12015.639530814002;12076.456559454846;12366;4111;4148.730332528376;4155.958440415588;4168.979155104205;4216.135692183095;57208.42791572073;58149.41850581482;59618.40381596172;60034.39965600332;60365.396346036854;10215;10541.683749487527;10597.364158150536;10679.359238445719;10692.62575809843;18405.26378944854;18680.53298667544;19465.610687786448;19506.70739938902;19554.511137221398;6465.418112369909;6699.564528305645;6724.798256052326;6728;6732.461403087741;3624.8341392385896;3638.3450978824067;3647.0335361129323;3737.289914916157;3775.4714339992424;2879.424115176973;2974.8810047597854;2975.9553606695918;2977.211039074647;2990.476666583339;570.9286339207599;589.6521052578998;592.1207007593806;599.5203836930439;602.8462742000762;498.5014985014985;500.90552143566424;507.77150282373077;514.2055524215097;528.5586535243038;7222.711091556384;7311.159216690043;7341.412686985029;7358.227386124487;7491.325780679765;506.79474812700914;513.0841448015275;515.6931625682713;518.9714565698847;528.6220352448019;3445.3798316303305;3521.3268016525135;3563.2873425315042;3706.314331848617;3727;100276;100540.49729751305;101545.49227253816;102429.48785256025;103230.48384758028;53865.46134538683;54178.729106354214;55700.16449753257;75305.62347188339;87187.56406217928;73205.6339718298;74077;74267.25732742711;74850;75651.9999999989;6948.722051117898;7058.188308344606;7088.751893683696;7191.928080719126;7309.342159205697;46792.7660361696;47627;48228;48497.75751121222;48811.26783098185;62551.74482551708;67406.32593674;67544.66227668831;68084;68163;9396.859047114162;9534.332596718441;9558.856617150888;9642.807143857224;9662.951685241529;10267.845982310122;10312.793744125225;10400.687979360631;10546.367217966947;10890.836637450286;9207.217386522221;9214.354995150543;9381.484018379055;9542.85685714701;9655.372400793925;8852.203301702877;8929.10708929102;8958.507282099547;9241.491717955578;9313.115254050854;8397.286230670461;8642.740717778477;8714;8820.911790882266;9040.095990400907;8465.534395608054;8522.140074727908;8563.443376180529;8804.647814087364;8935.597898094471;8147.307478864363;8401.15988401155;8424.241818236389;8493.10822363643;8518.488890666333 06:36:13 INFO - PROCESS | 7131 | __end_tp_report 06:36:13 INFO - PROCESS | 7131 | __start_cc_report 06:36:13 INFO - PROCESS | 7131 | _x_x_mozilla_cycle_collect,947 06:36:13 INFO - PROCESS | 7131 | __end_cc_report 06:36:13 INFO - PROCESS | 7131 | __startTimestamp1465392973575__endTimestamp 06:36:13 INFO - PROCESS | 7131 | 06:36:13 INFO - PROCESS | 7131 | ------- Summary: start ------- 06:36:13 INFO - PROCESS | 7131 | Number of tests: 6 06:36:13 INFO - PROCESS | 7131 | 06:36:13 INFO - PROCESS | 7131 | [#0] dojo.html Cycles:165 Average:4698.08 Median:4836.44 stddev:494.32 (10.2%) stddev-sans-first:469.64 06:36:13 INFO - PROCESS | 7131 | Values: 2673.9 2674.3 2708.2 2714.6 2725.3 4631.4 4686.4 4723.1 4753.3 4812.1 4705.4 4730.1 4744.2 4764.7 4783.7 4263.4 4295.2 4322.7 4344.6 4368.5 4379.5 4441.6 4464.9 4474.0 4511.0 4397.9 4442.7 4443.8 4455.7 4476.9 4247.8 4292.2 4299.9 4312.9 4313.6 4263.4 4289.2 4330.4 4342.2 4381.8 4663.7 4679.3 4688.1 4689.6 4698.2 4933.8 4993.8 5044.6 5049.3 5118.3 5078.7 5121.1 5127.3 5135.6 5142.3 4655.7 4719.3 4738.0 4745.3 4779.5 5147.8 5224.6 5234.1 5234.9 5296.9 5020.5 5059.0 5073.9 5075.3 5081.9 4918.8 5060.3 5109.8 5112.9 5136.7 5031.0 5058.3 5100.8 5110.2 5117.7 5032.2 5037.1 5044.4 5046.4 5096.4 4138.1 4247.1 4256.9 4258.4 4307.0 3674.7 3697.9 3700.0 3721.8 3761.0 4451.2 4460.9 4461.8 4485.1 4502.8 4977.5 5113.4 5124.1 5127.1 5180.7 4379.3 4394.3 4439.2 4453.6 4456.3 4509.6 4539.2 4546.6 4555.5 4580.6 4691.2 4836.4 4837.7 4839.0 4865.9 5043.8 5062.2 5115.6 5136.8 5137.0 4827.2 4848.8 4862.2 4871.5 4914.9 4897.9 5022.6 5056.5 5071.4 5125.6 5097.2 5158.3 5178.4 5179.3 5227.3 4996.5 5015.8 5019.8 5020.7 5065.9 4817.0 4825.3 4862.1 4998.5 5013.9 4823.7 4849.3 4850.2 4852.0 4853.6 4911.6 4912.0 4913.2 4924.4 4957.3 4692.7 4782.1 4840.5 4852.7 4875.6 06:36:13 INFO - PROCESS | 7131 | 06:36:13 INFO - PROCESS | 7131 | [#1] ext.html Cycles:180 Average:46199.02 Median:200380.73 stddev:81529.05 (40.7%) stddev-sans-first:81685.71 06:36:13 INFO - PROCESS | 7131 | Values: 546.7 591.1 591.5 594.0 605.0 28205.4 30526.7 30572.4 30575.8 30594.7 31000.4 42336.6 43110.8 43137.1 46447.3 7731.7 7901.1 7907.5 7908.6 7910.3 7792.6 7920.4 7923.1 7928.5 7931.2 7903.3 7934.6 7961.4 7965.2 7965.7 7854.4 7911.8 7917.9 7927.3 7929.2 7806.1 7890.1 7892.8 7893.4 7893.4 39289.6 39767.8 39801.0 39862.2 39881.4 2915.7 3035.7 3058.5 3090.1 3349.5 29637.7 30284.8 30293.4 30599.8 31101.4 3334.0 3337.3 3342.4 3356.2 3421.8 250907.0 252206.0 252531.0 252687.0 253224.0 56990.4 57478.7 57540.0 57576.7 57598.7 31511.5 32221.4 32288.0 33844.2 60636.7 13907.0 14063.4 14068.7 14104.4 14108.3 11150.1 11167.5 11362.9 11367.8 11394.5 18969.2 19049.3 19106.5 19126.2 19154.5 6481.3 6758.2 6767.5 6795.3 7104.8 757.5 858.0 992.0 1015.1 1022.0 28074.4 28174.6 28774.1 29356.4 29374.3 950.2 959.8 980.9 1001.2 1010.9 14609.3 14965.6 15111.2 15366.2 15413.3 364216.0 370183.0 370703.0 370803.0 374618.0 50633.5 51048.7 51194.5 51627.0 51673.5 1104.7 1187.6 1232.2 1238.9 1253.5 28366.7 29216.4 29368.4 29860.9 29993.6 42255.4 42904.1 42906.0 43053.6 43062.8 294981.0 296792.0 297462.0 298042.0 298266.0 22382.3 24502.3 25580.6 25631.9 25908.7 42948.8 43326.6 43374.0 44036.0 44037.3 36558.0 37234.4 37459.8 37471.9 38048.2 36545.5 37047.1 37144.3 37217.0 37264.3 36118.3 36893.3 37201.8 37639.8 37750.2 32081.7 32915.8 33467.0 33766.2 33807.7 25292.2 25358.9 25434.2 25548.1 25868.6 06:36:13 INFO - PROCESS | 7131 | 06:36:13 INFO - PROCESS | 7131 | [#2] jquery.html Cycles:180 Average:24490.33 Median:5245.90 stddev:66564.16 (1268.9%) stddev-sans-first:66726.24 06:36:13 INFO - PROCESS | 7131 | Values: 361.7 366.2 367.6 372.8 388.8 15399.4 17097.3 17140.4 17535.5 17635.2 16214.7 16356.7 17013.0 17017.8 17042.7 4971.7 5145.2 5149.6 5151.2 5153.7 3703.4 3920.1 5052.4 5687.0 5977.9 5996.6 6027.2 6035.7 6041.8 6044.9 5920.3 5942.9 6006.5 6007.4 6075.5 3395.6 4932.0 5245.0 5246.8 5301.5 19490.2 20153.2 20224.8 20225.1 20271.5 2247.6 2465.2 2483.2 2485.5 2498.1 12333.1 12943.9 13003.3 13178.2 13425.0 1723.4 1723.5 1778.6 1823.7 1856.6 65695.0 66026.7 66039.3 66330.0 67978.0 8813.1 8892.9 8967.6 9005.2 9055.9 11581.1 11646.5 11661.9 11688.6 11726.1 7103.4 7148.7 7193.5 7225.4 7233.1 6897.7 6980.9 7016.3 7074.0 7207.8 5822.5 5886.1 5968.1 6000.4 6002.2 1578.2 1695.5 1708.4 1718.3 1729.7 689.2 894.6 897.3 981.2 986.7 16343.5 17034.7 17218.8 17219.9 17316.4 833.5 849.6 856.2 902.6 970.1 8919.9 9297.8 9349.9 9413.2 9530.6 401860.0 402083.0 402095.0 403105.0 409208.0 76671.0 80639.0 80859.9 80959.6 81036.0 954.8 955.3 955.7 956.5 960.1 13745.0 14585.3 14673.5 14742.6 14925.7 26358.7 31545.4 34131.0 34619.4 34709.7 49280.8 50139.0 50695.7 50711.2 50736.5 7207.2 7329.9 7431.4 7462.4 7465.3 10522.2 11183.0 11289.5 11390.1 11417.4 8138.0 9525.9 9649.9 9671.5 9917.4 9932.2 9967.4 10172.5 10192.4 10305.5 9553.6 9782.3 9803.1 9983.0 10061.1 7195.9 7220.5 7337.3 7376.8 7874.8 7746.8 9736.7 9838.1 9910.9 10189.8 06:36:13 INFO - PROCESS | 7131 | 06:36:13 INFO - PROCESS | 7131 | [#3] mootools.html Cycles:180 Average:5160.30 Median:5311.58 stddev:2953.12 (55.6%) stddev-sans-first:2946.60 06:36:13 INFO - PROCESS | 7131 | Values: 1224.7 1389.8 1457.9 1528.9 1739.7 6735.4 7610.8 7845.7 7854.8 8076.4 7742.1 7909.9 7913.2 7921.7 8003.4 2116.1 2124.8 2141.6 2146.4 2147.6 2138.2 2156.1 2208.5 2213.8 2215.1 2145.8 2163.4 2172.3 2176.1 2182.5 2092.6 2095.8 2101.2 2101.9 2104.9 2069.8 2131.5 2137.5 2138.9 2140.6 7740.1 7895.6 7967.3 7969.5 7992.6 4717.9 4819.3 4836.3 4838.0 4844.4 2819.1 2913.1 2952.2 2962.6 2972.0 917.6 918.2 941.5 945.8 969.7 10866.2 10970.0 11000.4 11005.9 11019.9 4049.7 4095.8 4161.4 4216.2 4234.9 8673.0 8762.6 8768.6 8780.6 8782.4 4639.3 4675.8 4701.4 4705.7 4710.7 3608.1 3928.4 4257.4 4339.8 4404.3 3352.3 3380.2 3417.7 3443.9 3454.6 960.6 978.2 981.3 995.7 1007.9 812.3 815.9 829.6 830.9 849.7 5063.7 5307.1 5316.1 5317.8 5373.2 393.4 409.6 417.2 421.9 422.2 3568.1 3600.3 3608.1 3610.3 3674.0 9470.2 9742.8 9824.8 9841.2 9888.9 9689.1 9735.6 9751.0 9764.7 9786.2 7329.4 7371.7 7451.5 7592.5 7603.0 5244.0 5248.5 5277.4 5430.3 5464.2 8964.6 9162.5 9244.5 9252.9 9261.8 8657.8 8970.8 9019.9 9267.4 9316.4 5960.6 6269.5 6405.3 6431.1 6557.3 7678.9 7710.3 7760.2 7769.7 7781.8 6708.7 6740.6 6891.3 6975.3 7020.3 6840.9 6891.2 6936.4 6996.1 7064.2 6381.0 6501.7 6538.3 6560.6 6570.4 4642.7 4664.6 4685.3 4733.4 4771.0 4577.8 4620.9 4653.8 4723.0 4791.4 06:36:13 INFO - PROCESS | 7131 | 06:36:13 INFO - PROCESS | 7131 | [#4] prototype.html Cycles:180 Average:4147.12 Median:4751.61 stddev:1214.27 (25.6%) stddev-sans-first:1182.72 06:36:13 INFO - PROCESS | 7131 | Values: 293.3 293.7 294.7 298.9 302.5 4732.8 4785.8 4806.2 4814.0 4825.3 4703.8 4713.4 4736.1 4750.6 4752.6 3563.9 3659.5 3665.3 3683.4 3697.6 3589.4 3695.5 3789.7 3794.1 3800.4 3713.2 3731.0 3735.7 3750.3 3775.0 3646.4 3730.5 3731.0 3741.5 3743.4 3301.2 3318.6 3319.3 3320.7 3329.5 4504.6 4509.3 4520.3 4522.4 4549.9 4252.6 4271.2 4277.1 4293.3 4301.7 4719.9 4915.9 4930.8 4939.5 4941.9 3576.0 3577.7 3603.6 3604.0 3608.2 5172.9 5188.9 5204.7 5205.7 5214.0 3424.0 3627.0 3647.9 3650.5 3652.9 3646.3 3668.9 3672.9 3676.5 3680.5 4135.3 4136.8 4137.8 4163.9 4168.4 4966.9 4973.6 4981.8 4986.4 5008.4 1213.5 1251.8 1258.2 1258.3 1262.1 777.5 800.5 800.9 808.7 808.8 4253.7 4340.8 4442.4 4469.3 4480.9 5154.0 5156.2 5157.5 5166.9 5168.7 4430.7 4433.3 4447.8 4457.3 4461.2 2566.2 2694.6 2702.9 2713.5 2732.9 4874.3 4880.0 4886.5 4888.4 4890.5 5090.8 5216.1 5222.6 5260.8 5289.1 4848.8 4868.4 4885.2 4886.3 4902.0 5104.8 5125.1 5187.6 5190.9 5198.6 4775.0 5048.9 5071.2 5088.1 5101.6 4838.4 4846.6 4878.3 4878.9 4881.2 3566.7 3567.2 3589.8 3604.2 3614.7 5151.8 5164.4 5183.6 5187.1 5204.2 4760.2 5056.2 5060.3 5062.2 5090.3 4966.6 5000.5 5013.8 5049.6 5053.2 4840.7 4933.4 4958.1 4959.4 4975.4 4775.9 4944.7 5046.2 5064.8 5065.2 4950.3 4962.6 4967.9 4980.2 4992.3 06:36:13 INFO - PROCESS | 7131 | 06:36:13 INFO - PROCESS | 7131 | [#5] yui.html Cycles:180 Average:17053.90 Median:30316.96 stddev:24884.44 (82.1%) stddev-sans-first:24923.61 06:36:13 INFO - PROCESS | 7131 | Values: 608.7 613.2 626.0 697.1 701.9 12601.6 12615.1 12754.6 12788.4 12841.4 12229.4 12327.8 12566.2 13331.4 13332.6 787.3 789.0 798.8 799.3 799.7 634.5 788.0 794.2 796.8 818.6 832.7 835.6 837.7 846.5 847.7 659.3 835.3 837.4 837.5 838.7 596.5 601.9 608.9 613.2 613.4 12841.1 12854.6 12864.0 12866.7 12870.9 12391.9 12978.9 13003.2 13078.1 13198.7 11750.5 11982.9 12015.6 12076.5 12366.0 4111.0 4148.7 4156.0 4169.0 4216.1 57208.4 58149.4 59618.4 60034.4 60365.4 10215.0 10541.7 10597.4 10679.4 10692.6 18405.3 18680.5 19465.6 19506.7 19554.5 6465.4 6699.6 6724.8 6728.0 6732.5 3624.8 3638.3 3647.0 3737.3 3775.5 2879.4 2974.9 2976.0 2977.2 2990.5 570.9 589.7 592.1 599.5 602.8 498.5 500.9 507.8 514.2 528.6 7222.7 7311.2 7341.4 7358.2 7491.3 506.8 513.1 515.7 519.0 528.6 3445.4 3521.3 3563.3 3706.3 3727.0 100276.0 100540.5 101545.5 102429.5 103230.5 53865.5 54178.7 55700.2 75305.6 87187.6 73205.6 74077.0 74267.3 74850.0 75652.0 6948.7 7058.2 7088.8 7191.9 7309.3 46792.8 47627.0 48228.0 48497.8 48811.3 62551.7 67406.3 67544.7 68084.0 68163.0 9396.9 9534.3 9558.9 9642.8 9663.0 10267.8 10312.8 10400.7 10546.4 10890.8 9207.2 9214.4 9381.5 9542.9 9655.4 8852.2 8929.1 8958.5 9241.5 9313.1 8397.3 8642.7 8714.0 8820.9 9040.1 8465.5 8522.1 8563.4 8804.6 8935.6 8147.3 8401.2 8424.2 8493.1 8518.5 06:36:13 INFO - PROCESS | 7131 | -------- Summary: end -------- 06:36:13 INFO - PROCESS | 7131 | 06:36:14 INFO - TEST-INFO | 7131: exit 0 06:36:14 INFO - TEST-OK | dromaeo_css | took 1119122ms 06:36:14 INFO - TEST-START | kraken 06:36:14 INFO - operating with platform_type : linux_ 06:36:14 INFO - Initialising browser for kraken test... 06:36:14 INFO - TEST-INFO | started process 7308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhLZDx/profile http://localhost:43559/getInfo.html) 06:36:18 INFO - PROCESS | 7308 | __metrics Screen width/height:1600/1200 06:36:18 INFO - PROCESS | 7308 | colorDepth:24 06:36:18 INFO - PROCESS | 7308 | Browser inner width/height: 1024/697 06:36:18 INFO - PROCESS | 7308 | __metrics 06:36:18 ERROR - PROCESS | 7308 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:36:19 INFO - PROCESS | 7308 | console.error: PushService: 06:36:19 INFO - PROCESS | 7308 | stateChangeProcessEnqueue: Error transitioning state 06:36:19 INFO - PROCESS | 7308 | UnknownError 06:36:19 INFO - TEST-INFO | 7308: exit 0 06:36:19 INFO - Browser initialized. 06:36:19 INFO - Running cycle 1/1 for kraken test... 06:36:19 INFO - TEST-INFO | started process 7393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhLZDx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:36:31 INFO - PROCESS | 7393 | RSS: Main: 157257728 06:36:31 INFO - PROCESS | 7393 | 06:36:34 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43559/tests/kraken/driver.html?testName=audio-beat-detection) 06:36:35 INFO - PROCESS | 7393 | RSS: Main: 214515712 06:36:35 INFO - PROCESS | 7393 | 06:36:38 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43559/tests/kraken/driver.html?testName=audio-dft) 06:36:38 INFO - PROCESS | 7393 | RSS: Main: 201048064 06:36:38 INFO - PROCESS | 7393 | 06:36:42 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43559/tests/kraken/driver.html?testName=audio-fft) 06:36:42 INFO - PROCESS | 7393 | RSS: Main: 270241792 06:36:42 INFO - PROCESS | 7393 | 06:36:44 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43559/tests/kraken/driver.html?testName=audio-oscillator) 06:36:45 INFO - PROCESS | 7393 | RSS: Main: 180277248 06:36:45 INFO - PROCESS | 7393 | 06:36:47 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43559/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:36:48 INFO - PROCESS | 7393 | RSS: Main: 184791040 06:36:48 INFO - PROCESS | 7393 | 06:36:51 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43559/tests/kraken/driver.html?testName=imaging-darkroom) 06:36:52 INFO - PROCESS | 7393 | RSS: Main: 220606464 06:36:52 INFO - PROCESS | 7393 | 06:36:55 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43559/tests/kraken/driver.html?testName=imaging-desaturate) 06:36:56 INFO - PROCESS | 7393 | RSS: Main: 221364224 06:36:56 INFO - PROCESS | 7393 | 06:36:59 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43559/tests/kraken/driver.html?testName=json-parse-financial) 06:36:59 INFO - PROCESS | 7393 | RSS: Main: 220110848 06:36:59 INFO - PROCESS | 7393 | 06:37:01 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43559/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:37:01 INFO - PROCESS | 7393 | RSS: Main: 203497472 06:37:01 INFO - PROCESS | 7393 | 06:37:03 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43559/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:37:04 INFO - PROCESS | 7393 | RSS: Main: 209731584 06:37:04 INFO - PROCESS | 7393 | 06:37:06 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43559/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:37:07 INFO - PROCESS | 7393 | RSS: Main: 217960448 06:37:07 INFO - PROCESS | 7393 | 06:37:10 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43559/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:37:10 INFO - PROCESS | 7393 | RSS: Main: 222121984 06:37:10 INFO - PROCESS | 7393 | 06:37:13 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43559/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:37:14 INFO - PROCESS | 7393 | RSS: Main: 222142464 06:37:14 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | Cycle 1(1): loaded http://localhost:43559/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43559/tests/kraken/driver.html?testName=ai-astar) 06:37:16 INFO - PROCESS | 7393 | RSS: Main: 264413184 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | __start_tp_report 06:37:16 INFO - PROCESS | 7393 | _x_x_mozilla_page_load 06:37:16 INFO - PROCESS | 7393 | _x_x_mozilla_page_load_details 06:37:16 INFO - PROCESS | 7393 | |i|pagename|runs| 06:37:16 INFO - PROCESS | 7393 | |0;ai-astar;112;108;112;115;111;112;113;113;113;112 06:37:16 INFO - PROCESS | 7393 | |1;audio-beat-detection;161;137;134;177;136;132;150;130;200;130 06:37:16 INFO - PROCESS | 7393 | |2;audio-dft;162;161;161;161;162;162;163;161;161;161 06:37:16 INFO - PROCESS | 7393 | |3;audio-fft;75;77;77;129;76;79;74;74;106;76 06:37:16 INFO - PROCESS | 7393 | |4;audio-oscillator;86;86;122;88;88;86;119;86;87;125 06:37:16 INFO - PROCESS | 7393 | |5;imaging-gaussian-blur;116;117;117;117;118;117;118;117;117;117 06:37:16 INFO - PROCESS | 7393 | |6;imaging-darkroom;147;147;147;146;146;147;146;146;147;146 06:37:16 INFO - PROCESS | 7393 | |7;imaging-desaturate;94;95;96;95;95;94;95;95;95;94 06:37:16 INFO - PROCESS | 7393 | |8;json-parse-financial;61;61;63;63;62;62;63;63;63;61 06:37:16 INFO - PROCESS | 7393 | |9;json-stringify-tinderbox;65;65;64;64;65;65;65;64;66;66 06:37:16 INFO - PROCESS | 7393 | |10;stanford-crypto-aes;85;85;83;85;86;85;85;86;121;84 06:37:16 INFO - PROCESS | 7393 | |11;stanford-crypto-ccm;132;150;131;148;129;137;142;134;138;134 06:37:16 INFO - PROCESS | 7393 | |12;stanford-crypto-pbkdf2;171;171;169;168;173;170;173;171;168;166 06:37:16 INFO - PROCESS | 7393 | |13;stanford-crypto-sha256-iterative;68;69;68;67;67;68;66;66;67;65 06:37:16 INFO - PROCESS | 7393 | __end_tp_report 06:37:16 INFO - PROCESS | 7393 | __start_cc_report 06:37:16 INFO - PROCESS | 7393 | _x_x_mozilla_cycle_collect,1913 06:37:16 INFO - PROCESS | 7393 | __end_cc_report 06:37:16 INFO - PROCESS | 7393 | __startTimestamp1465393036287__endTimestamp 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | ------- Summary: start ------- 06:37:16 INFO - PROCESS | 7393 | Number of tests: 14 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:1.79 (1.6%) stddev-sans-first:1.90 06:37:16 INFO - PROCESS | 7393 | Values: 112.0 108.0 112.0 115.0 111.0 112.0 113.0 113.0 113.0 112.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:143.50 stddev:23.75 (16.6%) stddev-sans-first:24.77 06:37:16 INFO - PROCESS | 7393 | Values: 161.0 137.0 134.0 177.0 136.0 132.0 150.0 130.0 200.0 130.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 06:37:16 INFO - PROCESS | 7393 | Values: 162.0 161.0 161.0 161.0 162.0 162.0 163.0 161.0 161.0 161.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#3] audio-fft Cycles:10 Average:84.30 Median:76.00 stddev:18.38 (24.2%) stddev-sans-first:19.18 06:37:16 INFO - PROCESS | 7393 | Values: 75.0 77.0 77.0 129.0 76.0 79.0 74.0 74.0 106.0 76.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:86.00 stddev:17.12 (19.9%) stddev-sans-first:17.66 06:37:16 INFO - PROCESS | 7393 | Values: 86.0 86.0 122.0 88.0 88.0 86.0 119.0 86.0 87.0 125.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 06:37:16 INFO - PROCESS | 7393 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:37:16 INFO - PROCESS | 7393 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 06:37:16 INFO - PROCESS | 7393 | Values: 94.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 06:37:16 INFO - PROCESS | 7393 | Values: 61.0 61.0 63.0 63.0 62.0 62.0 63.0 63.0 63.0 61.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 06:37:16 INFO - PROCESS | 7393 | Values: 65.0 65.0 64.0 64.0 65.0 65.0 65.0 64.0 66.0 66.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:85.00 stddev:11.45 (13.5%) stddev-sans-first:12.08 06:37:16 INFO - PROCESS | 7393 | Values: 85.0 85.0 83.0 85.0 86.0 85.0 85.0 86.0 121.0 84.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:137.50 stddev:7.12 (5.2%) stddev-sans-first:7.27 06:37:16 INFO - PROCESS | 7393 | Values: 132.0 150.0 131.0 148.0 129.0 137.0 142.0 134.0 138.0 134.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:171.00 stddev:2.26 (1.3%) stddev-sans-first:2.37 06:37:16 INFO - PROCESS | 7393 | Values: 171.0 171.0 169.0 168.0 173.0 170.0 173.0 171.0 168.0 166.0 06:37:16 INFO - PROCESS | 7393 | 06:37:16 INFO - PROCESS | 7393 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.20 (1.8%) stddev-sans-first:1.22 06:37:16 INFO - PROCESS | 7393 | Values: 68.0 69.0 68.0 67.0 67.0 68.0 66.0 66.0 67.0 65.0 06:37:16 INFO - PROCESS | 7393 | -------- Summary: end -------- 06:37:16 INFO - PROCESS | 7393 | 06:37:17 INFO - TEST-INFO | 7393: exit 0 06:37:17 INFO - TEST-OK | kraken | took 63047ms 06:37:17 INFO - SUITE-END | took 1182s 06:37:17 INFO - Completed test suite (00:19:42) 06:37:17 INFO - javascript benchmark 06:37:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2673.906413275535, 2674.251209661293, 2708.1740069278867, 2714.647095877536, 2725.250556097073, 4631.374764406804, 4686.367340409044, 4723.149833030053, 4753.287006948955, 4812.109759694455, 4705.411823522059, 4730.053989202156, 4744.24092145256, 4764.690295130814, 4783.665143439961, 4263.360495925621, 4295.1839150561445, 4322.654187664987, 4344.608985191332, 4368.49762277339, 4379.474463064436, 4441.555844415549, 4464.866054018385, 4474.0, 4510.97744511277, 4397.9120417591785, 4442.689011769177, 4443.844465443694, 4455.665825063117, 4476.910461790762, 4247.766372849523, 4292.205941900727, 4299.871003869889, 4312.913741725148, 4313.590208930146, 4263.360495925605, 4289.227938970984, 4330.372096046056, 4342.196693611692, 4381.802818873159, 4663.673542852001, 4679.274712419547, 4688.085823264465, 4689.62483001359, 4698.248280275174, 4933.80264789408, 4993.7503124843615, 5044.621653376012, 5049.267856160836, 5118.2578526113875, 5078.669886457368, 5121.129408000649, 5127.256547800585, 5135.64050516464, 5142.305788718512, 4655.6973796703105, 4719.315699223594, 4738.028704115648, 4745.335653008581, 4779.522047795263, 5147.819826306136, 5224.634275600747, 5234.13636749932, 5234.895302093937, 5296.947030529723, 5020.548150666457, 5059.038782631288, 5073.949260507421, 5075.289459475676, 5081.872953176126, 4918.754062296871, 5060.342155519759, 5109.846704598868, 5112.948870511322, 5136.743162841843, 5031.0, 5058.342415485963, 5100.7959681613065, 5110.156824124052, 5117.692938423706, 5032.245163225545, 5037.143685573461, 5044.419891712427, 5046.394432668103, 5096.362954630671, 4138.110306284163, 4247.065645557972, 4256.936145957813, 4258.382534532538, 4307.009387840814, 3674.6876515495946, 3697.8520859165333, 3700.0, 3721.813909304524, 3761.0, 4451.243288640939, 4460.9107817844115, 4461.7992190351515, 4485.0805584855025, 4502.774861256924, 4977.477364876636, 5113.411957624847, 5124.128898087334, 5127.07712611726, 5180.7150606717, 4379.299312110047, 4394.252976993918, 4439.223135951195, 4453.599176074169, 4456.309272062771, 4509.616682582017, 4539.16025535277, 4546.61353784932, 4555.453345598549, 4580.587747102777, 4691.179043667276, 4836.443808961944, 4837.733924634179, 4839.0, 4865.878353041202, 5043.798248070036, 5062.190049592047, 5115.590752739847, 5136.768845401891, 5136.9743151284, 4827.227643577011, 4848.830290939942, 4862.222044472867, 4871.5128487151005, 4914.852554423373, 4897.853064408074, 5022.573081288131, 5056.494350564914, 5071.39143302806, 5125.5899528036925, 5097.209932460326, 5158.329417175743, 5178.352705911761, 5179.326687530597, 5227.294315267391, 4996.450390457119, 5015.824446144367, 5019.799208031638, 5020.698758074527, 5065.924011139762, 4816.975915120543, 4825.252085926687, 4862.05189987949, 4998.4501704813165, 5013.899722005613, 4823.710577365369, 4849.345338379415, 4850.1997170466475, 4851.981083972405, 4853.635977301646, 4911.63162762787, 4911.950880491149, 4913.238448040559, 4924.359833221658, 4957.256411538154, 4692.741899195577, 4782.0914026334885, 4840.540148685869, 4852.684575502581, 4875.561199492063], "value": 4666.764570020651, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.7184400033983, 591.0779184472224, 591.5179129009854, 593.9940600593993, 605.0410099991515, 28205.435891282163, 30526.694733052664, 30572.388552228942, 30575.847120764363, 30594.694053059462, 31000.37999240014, 42336.57663423365, 43110.78444607781, 43137.137257254835, 46447.30329045059, 7731.729389471356, 7901.051873775155, 7907.48601340911, 7908.644111014989, 7910.3276221520955, 7792.571408572526, 7920.36637069036, 7923.12845586985, 7928.524288542706, 7931.206879312081, 7903.3282171015535, 7934.642941067637, 7961.442699011071, 7965.24330188634, 7965.721199757981, 7854.410919181056, 7911.802204944865, 7917.920820791834, 7927.286544210991, 7929.167437419045, 7806.102298235719, 7890.053193616745, 7892.80267993299, 7893.407994400385, 7893.447458677895, 39289.60710392888, 39767.80116099401, 39801.0, 39862.20275594501, 39881.40177897334, 2915.7230063143966, 3035.741961933238, 3058.480058390079, 3090.072978106559, 3349.514320423525, 29637.70362296371, 30284.84857575698, 30293.394132117453, 30599.847000764854, 31101.377972440423, 3333.96666033339, 3337.2991671748964, 3342.398368293706, 3356.194513316811, 3421.828908554587, 250907.0, 252206.0, 252531.0, 252686.99999999817, 253224.0, 56990.43009569934, 57478.7126064367, 57540.0, 57576.71211643999, 57598.71200644054, 31511.527327090113, 32221.35557288841, 32288.0, 33844.15389615279, 60636.696816516516, 13907.026508144332, 14063.367148478139, 14068.71862562743, 14104.435822566982, 14108.294585270696, 11150.107991360834, 11167.497462614201, 11362.886371136348, 11367.829482557769, 11394.544218231344, 18969.24123035063, 19049.333273335644, 19106.52233694169, 19126.2349506021, 19154.52113697169, 6481.319461456479, 6758.189017317954, 6767.52627316093, 6795.25252222265, 7104.751333703295, 757.4849102610168, 857.9871301930476, 991.9950400248097, 1015.0864222200079, 1021.9591216351412, 28074.438511229662, 28174.577381339295, 28774.136775896757, 29356.412871742872, 29374.265643359086, 950.2208189284859, 959.8080383923243, 980.9411435313762, 1001.2090448545567, 1010.8981210480612, 14609.342579583945, 14965.551033469013, 15111.168885711171, 15366.231688415535, 15413.306401211748, 364216.0, 370183.0, 370703.0, 370803.0, 374618.0, 50633.49366506288, 51048.744756275984, 51194.48805511972, 51627.0, 51673.48326516687, 1104.7238190452388, 1187.5808408951393, 1232.2175418609067, 1238.8637249902504, 1253.5048655780915, 28366.716332836408, 29216.41567168687, 29368.412631746818, 29860.850695746383, 29993.55009674813, 42255.366169508095, 42904.14191716086, 42906.0, 43053.56946430621, 43062.78468607637, 294981.0, 296792.0, 297462.0, 298042.0, 298266.0, 22382.32853014412, 24502.264932051356, 25580.616290755283, 25631.871840640677, 25908.740912590634, 42948.78525607352, 43326.56673433226, 43374.0, 44036.0, 44037.33943990907, 36558.0, 37234.441483378316, 37459.81270093632, 37471.939043352875, 38048.23903521859, 36545.45181822222, 37047.073823154635, 37144.25711485809, 37217.0, 37264.25471490609, 36118.27763444664, 36893.26213475769, 37201.81399092987, 37639.81180094082, 37750.2449951005, 32081.679183208802, 32915.83542082274, 33467.0, 33766.15584610404, 33807.66192338045, 25292.241232763048, 25358.873205633852, 25434.23697289084, 25548.10581629634, 25868.611970820075], "value": 17448.065907096814, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.70521025364326, 366.15053076861676, 367.5901369972481, 372.7614326830828, 388.77256804769206, 15399.384024639015, 17097.31610735572, 17140.400085996993, 17535.473935781916, 17635.20641571129, 16214.675706485863, 16356.672866542693, 17013.0, 17017.82982170181, 17042.74435883463, 4971.651984361096, 5145.202493613496, 5149.588032957355, 5151.227315902607, 5153.716545589991, 3703.388940824774, 3920.0591857954173, 5052.418971818232, 5686.971565142168, 5977.88044239115, 5996.580239383245, 6027.246594175728, 6035.728392222339, 6041.761438905014, 6044.909326360108, 5920.259967504062, 5942.910856337158, 6006.519478441736, 6007.429294217064, 6075.544334174911, 3395.558577384949, 4931.9753401232765, 5244.973775131138, 5246.81636142737, 5301.469853014706, 19490.220391184335, 20153.193872245094, 20224.797752022587, 20225.089870955842, 20271.493212669655, 2247.6403775395856, 2465.235776909164, 2483.205374280231, 2485.5277497275642, 2498.088197807805, 12333.136680432284, 12943.870561294454, 13003.284819334933, 13178.209307441584, 13425.0, 1723.4484964811265, 1723.5087999919963, 1778.6353797471488, 1823.7446757453968, 1856.5982683074192, 65695.0, 66026.66986665085, 66039.3396066038, 66330.0, 67978.0, 8813.118688131264, 8892.911070889208, 8967.641294348283, 9005.189532942066, 9055.864162037575, 11581.07351411885, 11646.53413863453, 11661.88338116625, 11688.649340519798, 11726.120540959462, 7103.360697537247, 7148.676680078996, 7193.5324203926575, 7225.385842203472, 7233.095863017123, 6897.655117244118, 6980.895286570705, 7016.26329235423, 7073.964630176816, 7207.7837664869085, 5822.505087067647, 5886.146508756292, 5968.134620480006, 6000.399960003964, 6002.189704389852, 1578.2424436270655, 1695.508302592259, 1708.42767672831, 1718.269735362491, 1729.6540691861678, 689.1592257445908, 894.5974311559825, 897.3001059173855, 981.2003217377815, 986.7138529826414, 16343.509694709177, 17034.74447883283, 17218.827811721723, 17219.913900430416, 17316.39392621252, 833.4957350802798, 849.5582297205542, 856.1652388920752, 902.6479672927563, 970.0986067308155, 8919.866202006975, 9297.814043719223, 9349.90650093504, 9413.246940244764, 9530.618775248913, 401860.0, 402083.0, 402095.0, 403105.0, 409208.0, 76671.0, 80639.0, 80859.94926817581, 80959.59520202361, 81036.0, 954.7613096725958, 955.2930831184873, 955.6511873166244, 956.4691596164057, 960.0543464687278, 13745.0, 14585.343659535134, 14673.486427974969, 14742.63143421423, 14925.701485970438, 26358.73641263563, 31545.36909261848, 34130.976070717916, 34619.364966678135, 34709.65290347064, 49280.75359623179, 50139.0, 50695.74652126716, 50711.23933140932, 50736.49263507318, 7207.1711753146965, 7329.9267007329245, 7431.442641801778, 7462.365698915653, 7465.253474652709, 10522.210834187314, 11183.0, 11289.491972861406, 11390.088792896382, 11417.37204453763, 8138.0, 9525.904740952501, 9649.855252171083, 9671.516424178904, 9917.404955702681, 9932.205423566242, 9967.40195588267, 10172.542235599267, 10192.439415832201, 10305.484725763532, 9553.61785528599, 9782.266330025133, 9803.137403893237, 9983.0, 10061.14480269156, 7195.884637881137, 7220.4945653805835, 7337.26627337262, 7376.815579610553, 7874.763757087297, 7746.8450630985935, 9736.707898763048, 9838.114569688476, 9910.851337229804, 10189.796204076025], "value": 8227.621928614739, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1224.6999485126146, 1389.8332200135983, 1457.9198144102074, 1528.8547587979144, 1739.7216445368745, 6735.393814556689, 7610.771676849697, 7845.725399611015, 7854.803629909248, 8076.434649574532, 7742.14836367999, 7909.92090079099, 7913.248241417071, 7921.7227397041115, 8003.439759216857, 2116.0795054151417, 2124.840636952227, 2141.625215587274, 2146.420466474051, 2147.6456384696507, 2138.2302371146375, 2156.148321413049, 2208.4920468292303, 2213.845030847833, 2215.102883332253, 2145.8283337332978, 2163.405063607505, 2172.2831465616387, 2176.107795803721, 2182.5416662500893, 2092.5605622819226, 2095.8113769760716, 2101.1805395895612, 2101.8528702990798, 2104.936851894438, 2069.7826728193622, 2131.4777879419485, 2137.5297434564372, 2138.8823614701187, 2140.6360918643713, 7740.109887362969, 7895.60521973899, 7967.282944534962, 7969.521828690297, 7992.560409177493, 4717.905641887143, 4819.349387832633, 4836.322914791932, 4838.03239352131, 4844.394450693663, 2819.1401622505127, 2913.067818298124, 2952.2324195709057, 2962.6296712910885, 2972.038454619962, 917.5733284022895, 918.196577994255, 941.5245301122889, 945.7541039329824, 969.7139343893568, 10866.239363244576, 10970.0, 11000.449977501094, 11005.944970275177, 11019.944900275448, 4049.7367671101283, 4095.7917414362237, 4161.417401563784, 4216.156768646283, 4234.87295381139, 8673.04596494385, 8762.561871906379, 8768.561571921378, 8780.648774049094, 8782.385233033627, 4639.257718764981, 4675.7895894684825, 4701.3653156824075, 4705.670603057753, 4710.740909250024, 3608.0979755061235, 3928.371460566296, 4257.40396344512, 4339.804708788049, 4404.2512772828695, 3352.2625022495013, 3380.154961259685, 3417.658234176612, 3443.896683099511, 3454.6199918008997, 960.558143254097, 978.2320878110648, 981.3130808434124, 995.6515219673201, 1007.8740157480315, 812.308916010035, 815.9021709532863, 829.6017911402561, 830.9169083091642, 849.6601359456267, 5063.721495317719, 5307.097793375136, 5316.0696878046965, 5317.813876514303, 5373.196427775374, 393.41577757030785, 409.6190542795229, 417.230210262066, 421.8734379686082, 422.2315385997517, 3568.1436455250555, 3600.261946301002, 3608.116011577128, 3610.2598967211657, 3673.9816300918324, 9470.242380609534, 9742.805143897082, 9824.754381140387, 9841.163501102343, 9888.851667224997, 9689.079537443931, 9735.56189971453, 9751.0, 9764.707058788248, 9786.217102631916, 7329.413646908234, 7371.741989030465, 7451.478396512192, 7592.506487078323, 7603.0, 5244.0, 5248.501392367719, 5277.445868183939, 5430.266913966564, 5464.18037294409, 8964.596593153194, 9162.496062716615, 9244.491552964651, 9252.907470925205, 9261.76845578839, 8657.783555411164, 8970.775730606787, 9019.909800901907, 9267.44395336282, 9316.44101353921, 5960.612560183574, 6269.529785266032, 6405.295417504164, 6431.067495213074, 6557.311482294481, 7678.923210768045, 7710.344620707303, 7760.223977602194, 7769.72805951789, 7781.766547003599, 6708.731650733916, 6740.561863478858, 6891.276415976451, 6975.337342952412, 7020.297970202939, 6840.863182736218, 6891.241963384124, 6936.410405115622, 6996.0905082341005, 7064.152301723826, 6380.968095159495, 6501.739930402731, 6538.346165383424, 6560.639164845979, 6570.441512471493, 4642.698224615389, 4664.55686709762, 4685.320628508779, 4733.431988161443, 4770.952290477051, 4577.771111444348, 4620.930686039779, 4653.813847446199, 4723.0081682846985, 4791.448983366958], "value": 4049.8244156345445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.31657238633983, 293.69015688448684, 294.6537818063775, 298.91331513860956, 302.50691373061903, 4732.763361831908, 4785.808567657289, 4806.182948898691, 4813.9759301203485, 4825.300331451937, 4703.764811759407, 4713.43438787346, 4736.123817093831, 4750.596199323062, 4752.619790416767, 3563.9109022274392, 3659.5242618459565, 3665.332273815421, 3683.447482877563, 3697.5747789004204, 3589.3898037333715, 3695.5011073505, 3789.696824254053, 3794.1273507093383, 3800.429935509682, 3713.220223753015, 3730.9626903730887, 3735.701143908481, 3750.268697603968, 3775.0, 3646.4165733482514, 3730.459083432914, 3730.9813450932843, 3741.4948981887505, 3743.401055831054, 3301.207710149547, 3318.5851768528933, 3319.3029463812627, 3320.6717313074964, 3329.467285234351, 4504.639628829718, 4509.301058335963, 4520.276755719069, 4522.412086428776, 4549.886252843672, 4252.553481884389, 4271.209826182167, 4277.080427708027, 4293.3130699088, 4301.687700470651, 4719.905601887977, 4915.877103072416, 4930.753462326905, 4939.53074457926, 4941.861917682261, 3575.982120089409, 3577.6601222883783, 3603.6036036036016, 3604.0088975531676, 3608.2422691234874, 5172.948270517322, 5188.948110518884, 5204.661696989683, 5205.687658740488, 5213.973930130363, 3424.0, 3627.0207044097947, 3647.927041459156, 3650.452432135148, 3652.8538858445363, 3646.252518233756, 3668.8899333020054, 3672.926541469209, 3676.540432445944, 3680.4847321375028, 4135.29699951003, 4136.8003279048735, 4137.751734895855, 4163.917381480836, 4168.416421700964, 4966.925496117561, 4973.6269779765935, 4981.750912454435, 4986.376702912136, 5008.445692696678, 1213.538855235005, 1251.8059700746398, 1258.2261908925946, 1258.2576279994664, 1262.1291308996763, 777.4557809533236, 800.4636893281399, 800.8598495263423, 808.7452452477451, 808.8018435483226, 4253.659707223414, 4340.782960851945, 4442.42248507692, 4469.262571675702, 4480.932786008212, 5154.0, 5156.226566015052, 5157.535821775983, 5166.870828229249, 5168.689878607295, 4430.712003719748, 4433.334999750064, 4447.777611119431, 4457.331400289982, 4461.152381047591, 2566.2371326736397, 2694.5958106283824, 2702.945941081207, 2713.4668912065017, 2732.893178262807, 4874.317595536628, 4879.975600122048, 4886.53577910098, 4888.437829649564, 4890.486498917634, 5090.821821236313, 5216.087184742731, 5222.582193424517, 5260.763265653055, 5289.074411977888, 4848.781804818721, 4868.440129385166, 4885.218365061573, 4886.267059941038, 4901.950980490221, 5104.821331253537, 5125.128728116304, 5187.636865419385, 5190.948090519198, 5198.558122559625, 4775.021120670323, 5048.873778155576, 5071.163258062378, 5088.135017047037, 5101.591872650105, 4838.443578988321, 4846.588040016638, 4878.341423907727, 4878.90242195147, 4881.243407271879, 3566.6611671892165, 3567.1795487038644, 3589.802560859178, 3604.189057462155, 3614.6746792788776, 5151.819686311111, 5164.354455693038, 5183.637145399785, 5187.144121219956, 5204.245384419314, 4760.238361862085, 5056.165732654218, 5060.3168572242275, 5062.240663900445, 5090.312807771052, 4966.553010229097, 5000.549950504472, 5013.799448022039, 5049.57078648319, 5053.166227572557, 4840.7337596432535, 4933.432655244693, 4958.082754690394, 4959.380077490314, 4975.427825799935, 4775.928361074517, 4944.703317800943, 5046.21783623539, 5064.772085256099, 5065.164247899203, 4950.306957025947, 4962.560857351472, 4967.850964471072, 4980.186194799927, 4992.326035985241], "value": 3756.889708303644, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.7382425557008, 613.2457077794313, 625.9843503912405, 697.0624510034003, 701.8631366883458, 12601.621951341464, 12615.116941814076, 12754.55359062433, 12788.424520896559, 12841.42213600388, 12229.38853057348, 12327.824378372441, 12566.18319809214, 13331.40008699611, 13332.600021999331, 787.2678409079568, 789.0, 798.7683571764211, 799.312591171592, 799.6561478564215, 634.5494698763883, 787.9763607091796, 794.1859593916254, 796.760971708488, 818.6275244763618, 832.6919039955195, 835.6364981233183, 837.7151768398743, 846.5217152308957, 847.7202523167371, 659.320899473543, 835.3442547600135, 837.4347315562002, 837.5016864965397, 838.7064527415356, 596.5019208960523, 601.9428154325332, 608.8782243551308, 613.2426453330133, 613.3743581546842, 12841.1011229214, 12854.55009074678, 12864.0, 12866.678333041655, 12870.871291287154, 12391.876081239163, 12978.935105324414, 13003.219806811527, 13078.149920255153, 13198.73602527944, 11750.471228794639, 11982.880171198263, 12015.639530814002, 12076.456559454846, 12366.0, 4111.0, 4148.730332528376, 4155.958440415588, 4168.979155104205, 4216.135692183095, 57208.42791572073, 58149.41850581482, 59618.40381596172, 60034.39965600332, 60365.396346036854, 10215.0, 10541.683749487527, 10597.364158150536, 10679.359238445719, 10692.62575809843, 18405.26378944854, 18680.53298667544, 19465.610687786448, 19506.70739938902, 19554.511137221398, 6465.418112369909, 6699.564528305645, 6724.798256052326, 6728.0, 6732.461403087741, 3624.8341392385896, 3638.3450978824067, 3647.0335361129323, 3737.289914916157, 3775.4714339992424, 2879.424115176973, 2974.8810047597854, 2975.9553606695918, 2977.211039074647, 2990.476666583339, 570.9286339207599, 589.6521052578998, 592.1207007593806, 599.5203836930439, 602.8462742000762, 498.5014985014985, 500.90552143566424, 507.77150282373077, 514.2055524215097, 528.5586535243038, 7222.711091556384, 7311.159216690043, 7341.412686985029, 7358.227386124487, 7491.325780679765, 506.79474812700914, 513.0841448015275, 515.6931625682713, 518.9714565698847, 528.6220352448019, 3445.3798316303305, 3521.3268016525135, 3563.2873425315042, 3706.314331848617, 3727.0, 100276.0, 100540.49729751305, 101545.49227253816, 102429.48785256025, 103230.48384758028, 53865.46134538683, 54178.729106354214, 55700.16449753257, 75305.62347188339, 87187.56406217928, 73205.6339718298, 74077.0, 74267.25732742711, 74850.0, 75651.9999999989, 6948.722051117898, 7058.188308344606, 7088.751893683696, 7191.928080719126, 7309.342159205697, 46792.7660361696, 47627.0, 48228.0, 48497.75751121222, 48811.26783098185, 62551.74482551708, 67406.32593674, 67544.66227668831, 68084.0, 68163.0, 9396.859047114162, 9534.332596718441, 9558.856617150888, 9642.807143857224, 9662.951685241529, 10267.845982310122, 10312.793744125225, 10400.687979360631, 10546.367217966947, 10890.836637450286, 9207.217386522221, 9214.354995150543, 9381.484018379055, 9542.85685714701, 9655.372400793925, 8852.203301702877, 8929.10708929102, 8958.507282099547, 9241.491717955578, 9313.115254050854, 8397.286230670461, 8642.740717778477, 8714.0, 8820.911790882266, 9040.095990400907, 8465.534395608054, 8522.140074727908, 8563.443376180529, 8804.647814087364, 8935.597898094471, 8147.307478864363, 8401.15988401155, 8424.241818236389, 8493.10822363643, 8518.488890666333], "value": 6261.378514258854, "unit": "score"}], "name": "dromaeo_css", "value": 6321.747418390587, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 112.0, 115.0, 111.0, 112.0, 113.0, 113.0, 113.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 137.0, 134.0, 177.0, 136.0, 132.0, 150.0, 130.0, 200.0, 130.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 163.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 129.0, 76.0, 79.0, 74.0, 74.0, 106.0, 76.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 122.0, 88.0, 88.0, 86.0, 119.0, 86.0, 87.0, 125.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0, 61.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 66.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 83.0, 85.0, 86.0, 85.0, 85.0, 86.0, 121.0, 84.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 150.0, 131.0, 148.0, 129.0, 137.0, 142.0, 134.0, 138.0, 134.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 169.0, 168.0, 173.0, 170.0, 173.0, 171.0, 168.0, 166.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 67.0, 67.0, 68.0, 66.0, 66.0, 67.0, 65.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1552.5, "alertThreshold": 2.0}]} 06:37:17 INFO - Return code: 0 06:37:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:37:17 ERROR - # TBPL SUCCESS # 06:37:17 INFO - Running post-action listener: _resource_record_post_action 06:37:17 INFO - ##### 06:37:17 INFO - ##### Finished run-tests step (success) 06:37:17 INFO - ##### 06:37:17 INFO - Running post-run listener: _resource_record_post_run 06:37:17 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 421888; Write bytes: 285777920; Read time: 228; Write time: 228296 06:37:17 INFO - TinderboxPrint: CPU usage
13.1% 06:37:17 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 228 06:37:17 INFO - TinderboxPrint: I/O write bytes / time
285,777,920 / 228,296 06:37:17 INFO - TinderboxPrint: CPU idle
8,317.9 (86.9%) 06:37:17 INFO - TinderboxPrint: CPU user
1,212.9 (12.7%) 06:37:17 INFO - TinderboxPrint: Swap in / out
0 / 0 06:37:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1445888; Read time: 0; Write time: 292 06:37:17 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 421888; Write bytes: 284332032; Read time: 228; Write time: 228004 06:37:18 INFO - Running post-run listener: _upload_blobber_files 06:37:18 INFO - Blob upload gear active. 06:37:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:37:18 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 06:37:18 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'] 06:37:18 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 06:37:18 INFO - (blobuploader) - INFO - Open directory for files ... 06:37:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:37:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:37:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:19 INFO - (blobuploader) - INFO - Done attempting. 06:37:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:37:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:23 INFO - (blobuploader) - INFO - Done attempting. 06:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:37:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:37:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:37:24 INFO - (blobuploader) - INFO - Done attempting. 06:37:24 INFO - (blobuploader) - INFO - Iteration through files over. 06:37:24 INFO - Return code: 0 06:37:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:37:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:37:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7589d1c7b6bd8da542b222f9290cbf544cd4fb9cc882f0c52fff52ea87ddd320516215dec55e1cb495952b94d095855b14b1b3f9f51a0610326ebcb4638cd878", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b33880fa4b5a4a8e9dc63197699bdecfc3b8f82877e93c18a1e5399cf0670f03971e95d7ca2381b177c6fc3499384963f5d05eace36e16fd5ec065e1a5205227", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4cfe287ba4ace7024681e81dc2632e42129dfc2f0c98437dab105a65cbe30008d60cc81edf804ee370d74dddc027b11fe3ebea8c2ac1a9c1b47adf724c8db29c"} 06:37:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:37:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:37:24 INFO - Contents: 06:37:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7589d1c7b6bd8da542b222f9290cbf544cd4fb9cc882f0c52fff52ea87ddd320516215dec55e1cb495952b94d095855b14b1b3f9f51a0610326ebcb4638cd878", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b33880fa4b5a4a8e9dc63197699bdecfc3b8f82877e93c18a1e5399cf0670f03971e95d7ca2381b177c6fc3499384963f5d05eace36e16fd5ec065e1a5205227", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4cfe287ba4ace7024681e81dc2632e42129dfc2f0c98437dab105a65cbe30008d60cc81edf804ee370d74dddc027b11fe3ebea8c2ac1a9c1b47adf724c8db29c"} 06:37:24 INFO - Running post-run listener: copy_logs_to_upload_dir 06:37:24 INFO - Copying logs to upload dir... 06:37:24 INFO - mkdir: /builds/slave/test/build/upload/logs 06:37:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.849954 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-08 06:37:24.396550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 06:37:24.402014) ========= 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=923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692 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/7589d1c7b6bd8da542b222f9290cbf544cd4fb9cc882f0c52fff52ea87ddd320516215dec55e1cb495952b94d095855b14b1b3f9f51a0610326ebcb4638cd878", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b33880fa4b5a4a8e9dc63197699bdecfc3b8f82877e93c18a1e5399cf0670f03971e95d7ca2381b177c6fc3499384963f5d05eace36e16fd5ec065e1a5205227", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4cfe287ba4ace7024681e81dc2632e42129dfc2f0c98437dab105a65cbe30008d60cc81edf804ee370d74dddc027b11fe3ebea8c2ac1a9c1b47adf724c8db29c"} build_url:https://queue.taskcluster.net/v1/task/V_7lHl7KQg6-ysIVvf4FJw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/V_7lHl7KQg6-ysIVvf4FJw/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/7589d1c7b6bd8da542b222f9290cbf544cd4fb9cc882f0c52fff52ea87ddd320516215dec55e1cb495952b94d095855b14b1b3f9f51a0610326ebcb4638cd878", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b33880fa4b5a4a8e9dc63197699bdecfc3b8f82877e93c18a1e5399cf0670f03971e95d7ca2381b177c6fc3499384963f5d05eace36e16fd5ec065e1a5205227", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4cfe287ba4ace7024681e81dc2632e42129dfc2f0c98437dab105a65cbe30008d60cc81edf804ee370d74dddc027b11fe3ebea8c2ac1a9c1b47adf724c8db29c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 06:37:24.431139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 06:37:24.431501) ========= 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=923d835db2ba3686ebe126b700000192-1465391800.677250-2081285692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 06:37:24.517190) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 06:37:24.517942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 06:37:24.518667) ========= ========= Total master_lag: 0.20 =========