builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1465810705.44 results: success (0) buildid: 20160613013726 builduid: e10494be4997461cae7fdc4dd510588d revision: 405bdbc110e121282d453fcf66cbf0daa8c3441e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:25.438385) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:25.439807) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:25.440294) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:25.470584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:25.470873) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 02:38:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 31.3M=0s 2016-06-13 02:38:25 (31.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116999 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:25.602628) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:25.602909) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015944 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:25.654048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:25.654355) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 405bdbc110e121282d453fcf66cbf0daa8c3441e --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 405bdbc110e121282d453fcf66cbf0daa8c3441e --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=9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 02:38:25,810 truncating revision to first 12 chars 2016-06-13 02:38:25,810 Setting DEBUG logging. 2016-06-13 02:38:25,810 attempt 1/10 2016-06-13 02:38:25,810 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/405bdbc110e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 02:38:26,117 unpacking tar archive at: fx-team-405bdbc110e1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.709818 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:26.379048) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:26.379351) ========= script_repo_revision: 405bdbc110e121282d453fcf66cbf0daa8c3441e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:26.379768) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:26.380032) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:26.423314) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-13 02:38:26.423625) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:38:26 INFO - MultiFileLogger online at 20160613 02:38:26 in /builds/slave/test 02:38:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:38:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:38:26 INFO - {'append_to_log': False, 02:38:26 INFO - 'base_work_dir': '/builds/slave/test', 02:38:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:38:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:38:26 INFO - 'branch': 'Fx-Team-Non-PGO', 02:38:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:38:26 INFO - 'config_files': ('talos/linux_config.py',), 02:38:26 INFO - 'default_actions': ('clobber', 02:38:26 INFO - 'read-buildbot-config', 02:38:26 INFO - 'download-and-extract', 02:38:26 INFO - 'populate-webroot', 02:38:26 INFO - 'create-virtualenv', 02:38:26 INFO - 'install', 02:38:26 INFO - 'run-tests'), 02:38:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:38:26 INFO - 'download_minidump_stackwalk': True, 02:38:26 INFO - 'download_symbols': 'ondemand', 02:38:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:38:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:38:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:38:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:38:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:38:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:38:26 INFO - 'installer_path': 'installer.exe', 02:38:26 INFO - 'log_level': 'info', 02:38:26 INFO - 'log_name': 'talos', 02:38:26 INFO - 'log_to_console': True, 02:38:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:38:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:38:26 INFO - 'opt_config_files': (), 02:38:26 INFO - 'pip_index': False, 02:38:26 INFO - 'sps_profile': False, 02:38:26 INFO - 'sps_profile_interval': 0, 02:38:26 INFO - 'suite': 'dromaeojs', 02:38:26 INFO - 'system_bits': '32', 02:38:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:38:26 INFO - 'title': 'talos-linux64-ix-013', 02:38:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:38:26 INFO - 'use_talos_json': True, 02:38:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:38:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:38:26 INFO - 'work_dir': 'build'} 02:38:26 INFO - ##### 02:38:26 INFO - ##### Running clobber step. 02:38:26 INFO - ##### 02:38:26 INFO - Running pre-action listener: _resource_record_pre_action 02:38:26 INFO - Running main action method: clobber 02:38:26 INFO - rmtree: /builds/slave/test/build 02:38:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:38:27 INFO - Running post-action listener: _resource_record_post_action 02:38:27 INFO - ##### 02:38:27 INFO - ##### Finished clobber step (success) 02:38:27 INFO - ##### 02:38:27 INFO - ##### 02:38:27 INFO - ##### Running read-buildbot-config step. 02:38:27 INFO - ##### 02:38:27 INFO - Running pre-action listener: _resource_record_pre_action 02:38:27 INFO - Running main action method: read_buildbot_config 02:38:27 INFO - Using buildbot properties: 02:38:27 INFO - { 02:38:27 INFO - "project": "", 02:38:27 INFO - "product": "firefox", 02:38:27 INFO - "script_repo_revision": "production", 02:38:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:38:27 INFO - "repository": "", 02:38:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:38:27 INFO - "buildid": "20160613013726", 02:38:27 INFO - "pgo_build": "False", 02:38:27 INFO - "basedir": "/builds/slave/test", 02:38:27 INFO - "buildnumber": 1853, 02:38:27 INFO - "slavename": "talos-linux64-ix-013", 02:38:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:38:27 INFO - "platform": "ubuntu64_hw", 02:38:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:38:27 INFO - "branch": "fx-team", 02:38:27 INFO - "repo_path": "integration/fx-team", 02:38:27 INFO - "revision": "405bdbc110e121282d453fcf66cbf0daa8c3441e", 02:38:27 INFO - "stage_platform": "linux64", 02:38:27 INFO - "builduid": "e10494be4997461cae7fdc4dd510588d", 02:38:27 INFO - "slavebuilddir": "test" 02:38:27 INFO - } 02:38:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:38:27 INFO - Running post-action listener: _resource_record_post_action 02:38:27 INFO - ##### 02:38:27 INFO - ##### Finished read-buildbot-config step (success) 02:38:27 INFO - ##### 02:38:27 INFO - ##### 02:38:27 INFO - ##### Running download-and-extract step. 02:38:27 INFO - ##### 02:38:27 INFO - Running pre-action listener: _resource_record_pre_action 02:38:27 INFO - Running main action method: download_and_extract 02:38:27 INFO - mkdir: /builds/slave/test/build/tests 02:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:27 INFO - https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:38:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:38:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:38:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/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 02:38:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/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 02:38:27 INFO - Downloaded 1361 bytes. 02:38:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:38:27 INFO - Using the following test package requirements: 02:38:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:38:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:38:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:38:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:27 INFO - u'jsshell-linux-x86_64.zip'], 02:38:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:38:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:38:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:38:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:38:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:38:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:38:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:27 INFO - https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:38:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:38:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:38:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/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 02:38:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/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 02:38:28 INFO - Downloaded 22651503 bytes. 02:38:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:38:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:38:30 INFO - Return code: 0 02:38:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:30 INFO - https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:38:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:38:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:38:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/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 02:38:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/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 02:38:41 INFO - Downloaded 22651503 bytes. 02:38:41 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'] 02:38:41 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 02:38:42 INFO - Return code: 0 02:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:42 INFO - https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:38:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:38:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:38:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/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 02:38:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/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 02:38:43 INFO - Downloaded 14405384 bytes. 02:38:43 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'] 02:38:43 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 02:38:44 INFO - Return code: 0 02:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:44 INFO - https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:38:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:38:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:38:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/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 02:38:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/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 02:38:45 INFO - Downloaded 55397695 bytes. 02:38:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:38:45 INFO - mkdir: /builds/slave/test/properties 02:38:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:38:45 INFO - Writing to file /builds/slave/test/properties/build_url 02:38:45 INFO - Contents: 02:38:45 INFO - build_url:https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:38:46 INFO - Running post-action listener: _resource_record_post_action 02:38:46 INFO - Running post-action listener: set_extra_try_arguments 02:38:46 INFO - ##### 02:38:46 INFO - ##### Finished download-and-extract step (success) 02:38:46 INFO - ##### 02:38:46 INFO - ##### 02:38:46 INFO - ##### Running populate-webroot step. 02:38:46 INFO - ##### 02:38:46 INFO - Running pre-action listener: _resource_record_pre_action 02:38:46 INFO - Running main action method: populate_webroot 02:38:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:38:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:38:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:38:46 INFO - '--tppagecycles', 02:38:46 INFO - '7'], 02:38:46 INFO - 'tests': ['tsvgm']}}, 02:38:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:38:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:38:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:38:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:38:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:38:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:38:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:46 INFO - 'talos_options': ['--disable-e10s'], 02:38:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:46 INFO - 'talos_options': ['--disable-e10s'], 02:38:46 INFO - 'tests': ['damp', 'tps']}, 02:38:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:46 INFO - 'tests': ['damp', 'tps']}, 02:38:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:38:46 INFO - 'tests': ['dromaeo_dom']}, 02:38:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:38:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:38:46 INFO - 'tests': ['basic_compositor_video']}, 02:38:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:38:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:38:46 INFO - 'tests': ['a11yr', 02:38:46 INFO - 'ts_paint', 02:38:46 INFO - 'tpaint', 02:38:46 INFO - 'sessionrestore', 02:38:46 INFO - 'sessionrestore_no_auto_restore', 02:38:46 INFO - 'tabpaint']}, 02:38:46 INFO - 'other-e10s': {'tests': ['a11yr', 02:38:46 INFO - 'ts_paint', 02:38:46 INFO - 'tpaint', 02:38:46 INFO - 'sessionrestore', 02:38:46 INFO - 'sessionrestore_no_auto_restore', 02:38:46 INFO - 'tabpaint']}, 02:38:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:38:46 INFO - 'ts_paint', 02:38:46 INFO - 'tpaint', 02:38:46 INFO - 'sessionrestore', 02:38:46 INFO - 'sessionrestore_no_auto_restore', 02:38:46 INFO - 'tabpaint']}, 02:38:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:38:46 INFO - 'ts_paint', 02:38:46 INFO - 'tpaint', 02:38:46 INFO - 'sessionrestore', 02:38:46 INFO - 'sessionrestore_no_auto_restore', 02:38:46 INFO - 'tabpaint']}, 02:38:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:38:46 INFO - 'tests': ['a11yr', 02:38:46 INFO - 'ts_paint', 02:38:46 INFO - 'tpaint', 02:38:46 INFO - 'sessionrestore', 02:38:46 INFO - 'sessionrestore_no_auto_restore', 02:38:46 INFO - 'tabpaint']}, 02:38:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:38:46 INFO - 'tests': ['a11yr', 02:38:46 INFO - 'ts_paint', 02:38:46 INFO - 'tpaint', 02:38:46 INFO - 'sessionrestore', 02:38:46 INFO - 'sessionrestore_no_auto_restore', 02:38:46 INFO - 'tabpaint']}, 02:38:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:38:46 INFO - 'tests': ['tsvgx', 02:38:46 INFO - 'tsvgr_opacity', 02:38:46 INFO - 'tart', 02:38:46 INFO - 'tscrollx', 02:38:46 INFO - 'cart']}, 02:38:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:38:46 INFO - 'tsvgr_opacity', 02:38:46 INFO - 'tart', 02:38:46 INFO - 'tscrollx', 02:38:46 INFO - 'cart']}, 02:38:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:46 INFO - 'talos_options': ['--disable-e10s'], 02:38:46 INFO - 'tests': ['tp5o']}, 02:38:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:46 INFO - 'tests': ['tp5o']}, 02:38:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:46 INFO - 'talos_options': ['--disable-e10s', 02:38:46 INFO - '--xperf_path', 02:38:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:46 INFO - 'tests': ['tp5n']}, 02:38:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:46 INFO - 'talos_options': ['--xperf_path', 02:38:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:46 INFO - 'tests': ['tp5n']}}, 02:38:46 INFO - 'talos.zip': {'path': '', 02:38:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:38:46 INFO - Running post-action listener: _resource_record_post_action 02:38:46 INFO - ##### 02:38:46 INFO - ##### Finished populate-webroot step (success) 02:38:46 INFO - ##### 02:38:46 INFO - ##### 02:38:46 INFO - ##### Running create-virtualenv step. 02:38:46 INFO - ##### 02:38:46 INFO - Running pre-action listener: _resource_record_pre_action 02:38:46 INFO - Running main action method: create_virtualenv 02:38:46 INFO - Creating virtualenv /builds/slave/test/build/venv 02:38:46 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 02:38:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:38:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:38:46 INFO - Using real prefix '/usr' 02:38:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:38:47 INFO - Installing distribute.............................................................................................................................................................................................done. 02:38:49 INFO - Installing pip.................done. 02:38:49 INFO - Return code: 0 02:38:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:38: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')]} 02:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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')]} 02:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4dc4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e2e0>, '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 0x139a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139a5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', '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 02:38:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:38:49 INFO - Using env: {'DISPLAY': ':0', 02:38:49 INFO - 'HOME': '/home/cltbld', 02:38:49 INFO - 'LANG': 'en_US.UTF-8', 02:38:49 INFO - 'LANGUAGE': 'en_US:en', 02:38:49 INFO - 'LOGNAME': 'cltbld', 02:38:49 INFO - 'MAIL': '/var/mail/cltbld', 02:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:49 INFO - 'MOZ_NO_REMOTE': '1', 02:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:49 INFO - 'NO_EM_RESTART': '1', 02:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:49 INFO - 'PWD': '/builds/slave/test', 02:38:49 INFO - 'SHELL': '/bin/bash', 02:38:49 INFO - 'SHLVL': '1', 02:38:49 INFO - 'TERM': 'linux', 02:38:49 INFO - 'TMOUT': '86400', 02:38:49 INFO - 'USER': 'cltbld', 02:38:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', 02:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:49 INFO - '_': '/tools/buildbot/bin/python'} 02:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:49 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 02:38:49 INFO - Cleaning up... 02:38:49 INFO - Return code: 0 02:38:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:38: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')]} 02:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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')]} 02:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff4dc4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e2e0>, '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 0x139a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139a5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', '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 02:38:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:38:49 INFO - Using env: {'DISPLAY': ':0', 02:38:49 INFO - 'HOME': '/home/cltbld', 02:38:49 INFO - 'LANG': 'en_US.UTF-8', 02:38:49 INFO - 'LANGUAGE': 'en_US:en', 02:38:49 INFO - 'LOGNAME': 'cltbld', 02:38:49 INFO - 'MAIL': '/var/mail/cltbld', 02:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:49 INFO - 'MOZ_NO_REMOTE': '1', 02:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:49 INFO - 'NO_EM_RESTART': '1', 02:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:49 INFO - 'PWD': '/builds/slave/test', 02:38:49 INFO - 'SHELL': '/bin/bash', 02:38:49 INFO - 'SHLVL': '1', 02:38:49 INFO - 'TERM': 'linux', 02:38:49 INFO - 'TMOUT': '86400', 02:38:49 INFO - 'USER': 'cltbld', 02:38:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', 02:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:49 INFO - '_': '/tools/buildbot/bin/python'} 02:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:49 INFO - Downloading/unpacking psutil>=3.1.1 02:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:38:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:51 INFO - Installing collected packages: psutil 02:38:51 INFO - Running setup.py install for psutil 02:38:51 INFO - building 'psutil._psutil_linux' extension 02:38:51 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 02:38:51 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 02:38:51 INFO - building 'psutil._psutil_posix' extension 02:38:51 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 02:38:52 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 02:38:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:52 INFO - Successfully installed psutil 02:38:52 INFO - Cleaning up... 02:38:52 INFO - Return code: 0 02:38:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:38:52 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')]} 02:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:52 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')]} 02:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:52 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 0x7ff4dc4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e2e0>, '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 0x139a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139a5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', '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 02:38:52 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 02:38:52 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 02:38:52 INFO - Using env: {'DISPLAY': ':0', 02:38:52 INFO - 'HOME': '/home/cltbld', 02:38:52 INFO - 'LANG': 'en_US.UTF-8', 02:38:52 INFO - 'LANGUAGE': 'en_US:en', 02:38:52 INFO - 'LOGNAME': 'cltbld', 02:38:52 INFO - 'MAIL': '/var/mail/cltbld', 02:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:52 INFO - 'MOZ_NO_REMOTE': '1', 02:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:52 INFO - 'NO_EM_RESTART': '1', 02:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:52 INFO - 'PWD': '/builds/slave/test', 02:38:52 INFO - 'SHELL': '/bin/bash', 02:38:52 INFO - 'SHLVL': '1', 02:38:52 INFO - 'TERM': 'linux', 02:38:52 INFO - 'TMOUT': '86400', 02:38:52 INFO - 'USER': 'cltbld', 02:38:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', 02:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:52 INFO - '_': '/tools/buildbot/bin/python'} 02:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:38:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:38:54 INFO - Installing collected packages: mozsystemmonitor 02:38:54 INFO - Running setup.py install for mozsystemmonitor 02:38:54 INFO - Successfully installed mozsystemmonitor 02:38:54 INFO - Cleaning up... 02:38:54 INFO - Return code: 0 02:38:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:38: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')]} 02:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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')]} 02:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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', '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 0x7ff4dc4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e2e0>, '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 0x139a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139a5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', '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 02:38: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:38: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 jsonschema==2.5.1 02:38:54 INFO - Using env: {'DISPLAY': ':0', 02:38:54 INFO - 'HOME': '/home/cltbld', 02:38:54 INFO - 'LANG': 'en_US.UTF-8', 02:38:54 INFO - 'LANGUAGE': 'en_US:en', 02:38:54 INFO - 'LOGNAME': 'cltbld', 02:38:54 INFO - 'MAIL': '/var/mail/cltbld', 02:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:54 INFO - 'MOZ_NO_REMOTE': '1', 02:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:54 INFO - 'NO_EM_RESTART': '1', 02:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:54 INFO - 'PWD': '/builds/slave/test', 02:38:54 INFO - 'SHELL': '/bin/bash', 02:38:54 INFO - 'SHLVL': '1', 02:38:54 INFO - 'TERM': 'linux', 02:38:54 INFO - 'TMOUT': '86400', 02:38:54 INFO - 'USER': 'cltbld', 02:38:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', 02:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:54 INFO - '_': '/tools/buildbot/bin/python'} 02:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:54 INFO - Downloading/unpacking jsonschema==2.5.1 02:38:54 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 02:38:54 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 02:38:54 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 02:38:54 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 02:38:54 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 02:38:54 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 02:38:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:38:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:38:56 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 02:38:56 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 02:38:56 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 02:38:56 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 02:38:56 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 02:38:56 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 02:38:56 INFO - Downloading functools32-3.2.3-2.tar.gz 02:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:38:56 INFO - warning: no files found matching '*.txt' 02:38:56 INFO - no previously-included directories found matching 'build' 02:38:56 INFO - no previously-included directories found matching 'dist' 02:38:56 INFO - no previously-included directories found matching '.git*' 02:38:56 INFO - Installing collected packages: jsonschema, functools32 02:38:56 INFO - Running setup.py install for functools32 02:38:56 INFO - warning: no files found matching '*.txt' 02:38:56 INFO - no previously-included directories found matching 'build' 02:38:56 INFO - no previously-included directories found matching 'dist' 02:38:56 INFO - no previously-included directories found matching '.git*' 02:38:57 INFO - Successfully installed jsonschema functools32 02:38:57 INFO - Cleaning up... 02:38:57 INFO - Return code: 0 02:38:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff4dc4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e2e0>, '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 0x139a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139a5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', '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 02:38:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:38:57 INFO - Using env: {'DISPLAY': ':0', 02:38:57 INFO - 'HOME': '/home/cltbld', 02:38:57 INFO - 'LANG': 'en_US.UTF-8', 02:38:57 INFO - 'LANGUAGE': 'en_US:en', 02:38:57 INFO - 'LOGNAME': 'cltbld', 02:38:57 INFO - 'MAIL': '/var/mail/cltbld', 02:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:57 INFO - 'MOZ_NO_REMOTE': '1', 02:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:57 INFO - 'NO_EM_RESTART': '1', 02:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:57 INFO - 'PWD': '/builds/slave/test', 02:38:57 INFO - 'SHELL': '/bin/bash', 02:38:57 INFO - 'SHLVL': '1', 02:38:57 INFO - 'TERM': 'linux', 02:38:57 INFO - 'TMOUT': '86400', 02:38:57 INFO - 'USER': 'cltbld', 02:38:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', 02:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:57 INFO - '_': '/tools/buildbot/bin/python'} 02:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:57 INFO - Downloading/unpacking blobuploader==1.2.4 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38: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 02:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:59 INFO - Downloading blobuploader-1.2.4.tar.gz 02:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:38:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:38:59 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 02:38:59 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 02:38:59 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 02:38:59 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 02:38:59 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 02:38:59 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 02:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:38:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:38:59 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 02:38:59 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 02:38:59 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 02:38:59 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 02:38:59 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 02:38:59 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 02:38:59 INFO - Downloading docopt-0.6.1.tar.gz 02:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:38:59 INFO - Installing collected packages: blobuploader, requests, docopt 02:38:59 INFO - Running setup.py install for blobuploader 02:38:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:39:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:39:00 INFO - Running setup.py install for requests 02:39:00 INFO - Running setup.py install for docopt 02:39:00 INFO - Successfully installed blobuploader requests docopt 02:39:00 INFO - Cleaning up... 02:39:00 INFO - Return code: 0 02:39:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:00 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 0x7ff4dc4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e2e0>, '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 0x139a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139a5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', '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 02:39:00 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 02:39:00 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 02:39:00 INFO - Using env: {'DISPLAY': ':0', 02:39:00 INFO - 'HOME': '/home/cltbld', 02:39:00 INFO - 'LANG': 'en_US.UTF-8', 02:39:00 INFO - 'LANGUAGE': 'en_US:en', 02:39:00 INFO - 'LOGNAME': 'cltbld', 02:39:00 INFO - 'MAIL': '/var/mail/cltbld', 02:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:00 INFO - 'MOZ_NO_REMOTE': '1', 02:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:00 INFO - 'NO_EM_RESTART': '1', 02:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:00 INFO - 'PWD': '/builds/slave/test', 02:39:00 INFO - 'SHELL': '/bin/bash', 02:39:00 INFO - 'SHLVL': '1', 02:39:00 INFO - 'TERM': 'linux', 02:39:00 INFO - 'TMOUT': '86400', 02:39:00 INFO - 'USER': 'cltbld', 02:39:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', 02:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:00 INFO - '_': '/tools/buildbot/bin/python'} 02:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:00 INFO - Running setup.py (path:/tmp/pip-FiMNGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:00 INFO - Running setup.py (path:/tmp/pip-ziVwkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:00 INFO - Running setup.py (path:/tmp/pip-ob39ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:00 INFO - Running setup.py (path:/tmp/pip-rmolWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:01 INFO - Running setup.py (path:/tmp/pip-qbz7eE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:01 INFO - Running setup.py (path:/tmp/pip-0mwb5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:01 INFO - Running setup.py (path:/tmp/pip-e176mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:01 INFO - Running setup.py (path:/tmp/pip-X1BFcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:01 INFO - Running setup.py (path:/tmp/pip-rUjmku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:01 INFO - Running setup.py (path:/tmp/pip-K2PN3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:01 INFO - Running setup.py (path:/tmp/pip-znDbSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:01 INFO - Running setup.py (path:/tmp/pip-DypMhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:01 INFO - Running setup.py (path:/tmp/pip-Kg_WCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:01 INFO - Running setup.py (path:/tmp/pip-X1z3zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:01 INFO - Running setup.py (path:/tmp/pip-xSElAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:01 INFO - Running setup.py (path:/tmp/pip-zqJAcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:01 INFO - Running setup.py (path:/tmp/pip-J8PSac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:39:01 INFO - Running setup.py install for manifestparser 02:39:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:39:02 INFO - Running setup.py install for mozcrash 02:39:02 INFO - Running setup.py install for mozdebug 02:39:02 INFO - Running setup.py install for mozdevice 02:39:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:39:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:39:02 INFO - Running setup.py install for mozfile 02:39:02 INFO - Running setup.py install for mozhttpd 02:39:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:39:02 INFO - Running setup.py install for mozinfo 02:39:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:39:02 INFO - Running setup.py install for mozInstall 02:39:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:39:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:39:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:39:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:39:02 INFO - Running setup.py install for mozleak 02:39:02 INFO - Running setup.py install for mozlog 02:39:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:39:02 INFO - Running setup.py install for moznetwork 02:39:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:39:03 INFO - Running setup.py install for mozprocess 02:39:03 INFO - Running setup.py install for mozprofile 02:39:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:39:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:39:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:39:03 INFO - Running setup.py install for mozrunner 02:39:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:39:03 INFO - Running setup.py install for mozscreenshot 02:39:03 INFO - Running setup.py install for moztest 02:39:03 INFO - Running setup.py install for mozversion 02:39:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:39:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:39:03 INFO - Cleaning up... 02:39:03 INFO - Return code: 0 02:39:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:03 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 0x7ff4dc4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e2e0>, '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 0x139a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139a5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', '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 02:39:03 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 02:39:03 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 02:39:03 INFO - Using env: {'DISPLAY': ':0', 02:39:03 INFO - 'HOME': '/home/cltbld', 02:39:03 INFO - 'LANG': 'en_US.UTF-8', 02:39:03 INFO - 'LANGUAGE': 'en_US:en', 02:39:03 INFO - 'LOGNAME': 'cltbld', 02:39:03 INFO - 'MAIL': '/var/mail/cltbld', 02:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:03 INFO - 'MOZ_NO_REMOTE': '1', 02:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:03 INFO - 'NO_EM_RESTART': '1', 02:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:03 INFO - 'PWD': '/builds/slave/test', 02:39:03 INFO - 'SHELL': '/bin/bash', 02:39:03 INFO - 'SHLVL': '1', 02:39:03 INFO - 'TERM': 'linux', 02:39:03 INFO - 'TMOUT': '86400', 02:39:03 INFO - 'USER': 'cltbld', 02:39:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', 02:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:03 INFO - '_': '/tools/buildbot/bin/python'} 02:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:03 INFO - Running setup.py (path:/tmp/pip-1kB2jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:04 INFO - Running setup.py (path:/tmp/pip-Flo3_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:04 INFO - Running setup.py (path:/tmp/pip-2KFXaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:04 INFO - Running setup.py (path:/tmp/pip-_YAlcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:04 INFO - Running setup.py (path:/tmp/pip-c9GSru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:04 INFO - Running setup.py (path:/tmp/pip-rjT7qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:04 INFO - Running setup.py (path:/tmp/pip-gwhXJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:04 INFO - Running setup.py (path:/tmp/pip-XICAnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:04 INFO - Running setup.py (path:/tmp/pip-wUuV6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:04 INFO - Running setup.py (path:/tmp/pip-XtLXDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:04 INFO - Running setup.py (path:/tmp/pip-yHv0wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:04 INFO - Running setup.py (path:/tmp/pip-NS4kh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:04 INFO - Running setup.py (path:/tmp/pip-PWHS70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:04 INFO - Running setup.py (path:/tmp/pip-yhwOZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:04 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)) 02:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:04 INFO - Running setup.py (path:/tmp/pip-MlqVtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:05 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)) 02:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:05 INFO - Running setup.py (path:/tmp/pip-gnsfVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:05 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)) 02:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:05 INFO - Running setup.py (path:/tmp/pip-cPwdNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 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)) 02:39:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:07 INFO - Downloading blessings-1.6.tar.gz 02:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:39:07 INFO - Installing collected packages: blessings 02:39:07 INFO - Running setup.py install for blessings 02:39:07 INFO - Successfully installed blessings 02:39:07 INFO - Cleaning up... 02:39:07 INFO - Return code: 0 02:39:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:39:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:07 INFO - Reading from file tmpfile_stdout 02:39:07 INFO - Current package versions: 02:39:07 INFO - argparse == 1.2.1 02:39:07 INFO - blessings == 1.6 02:39:07 INFO - blobuploader == 1.2.4 02:39:07 INFO - docopt == 0.6.1 02:39:07 INFO - functools32 == 3.2.3-2 02:39:07 INFO - jsonschema == 2.5.1 02:39:07 INFO - manifestparser == 1.1 02:39:07 INFO - mozInstall == 1.12 02:39:07 INFO - mozcrash == 0.17 02:39:07 INFO - mozdebug == 0.1 02:39:07 INFO - mozdevice == 0.48 02:39:07 INFO - mozfile == 1.2 02:39:07 INFO - mozhttpd == 0.7 02:39:07 INFO - mozinfo == 0.9 02:39:07 INFO - mozleak == 0.1 02:39:07 INFO - mozlog == 3.2 02:39:07 INFO - moznetwork == 0.27 02:39:07 INFO - mozprocess == 0.22 02:39:07 INFO - mozprofile == 0.28 02:39:07 INFO - mozrunner == 6.11 02:39:07 INFO - mozscreenshot == 0.1 02:39:07 INFO - mozsystemmonitor == 0.3 02:39:07 INFO - moztest == 0.7 02:39:07 INFO - mozversion == 1.4 02:39:07 INFO - psutil == 3.1.1 02:39:07 INFO - requests == 1.2.3 02:39:07 INFO - wsgiref == 0.1.2 02:39:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:07 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 0x7ff4dc4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e2e0>, '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 0x139a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139a5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', '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 02:39:07 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 02:39:07 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 02:39:07 INFO - Using env: {'DISPLAY': ':0', 02:39:07 INFO - 'HOME': '/home/cltbld', 02:39:07 INFO - 'LANG': 'en_US.UTF-8', 02:39:07 INFO - 'LANGUAGE': 'en_US:en', 02:39:07 INFO - 'LOGNAME': 'cltbld', 02:39:07 INFO - 'MAIL': '/var/mail/cltbld', 02:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:07 INFO - 'MOZ_NO_REMOTE': '1', 02:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:07 INFO - 'NO_EM_RESTART': '1', 02:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:07 INFO - 'PWD': '/builds/slave/test', 02:39:07 INFO - 'SHELL': '/bin/bash', 02:39:07 INFO - 'SHLVL': '1', 02:39:07 INFO - 'TERM': 'linux', 02:39:07 INFO - 'TMOUT': '86400', 02:39:07 INFO - 'USER': 'cltbld', 02:39:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', 02:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:07 INFO - '_': '/tools/buildbot/bin/python'} 02:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:07 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)) 02:39:07 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)) 02:39:07 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)) 02:39:07 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)) 02:39:07 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)) 02:39:07 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)) 02:39:07 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)) 02:39:07 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)) 02:39:07 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)) 02:39:07 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)) 02:39:07 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)) 02:39:07 INFO - Cleaning up... 02:39:07 INFO - Return code: 0 02:39:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:07 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 0x7ff4dc4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e2e0>, '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 0x139a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139a5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', '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 02:39:07 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 02:39:07 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 02:39:07 INFO - Using env: {'DISPLAY': ':0', 02:39:07 INFO - 'HOME': '/home/cltbld', 02:39:07 INFO - 'LANG': 'en_US.UTF-8', 02:39:07 INFO - 'LANGUAGE': 'en_US:en', 02:39:07 INFO - 'LOGNAME': 'cltbld', 02:39:07 INFO - 'MAIL': '/var/mail/cltbld', 02:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:07 INFO - 'MOZ_NO_REMOTE': '1', 02:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:07 INFO - 'NO_EM_RESTART': '1', 02:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:07 INFO - 'PWD': '/builds/slave/test', 02:39:07 INFO - 'SHELL': '/bin/bash', 02:39:07 INFO - 'SHLVL': '1', 02:39:07 INFO - 'TERM': 'linux', 02:39:07 INFO - 'TMOUT': '86400', 02:39:07 INFO - 'USER': 'cltbld', 02:39:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', 02:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:07 INFO - '_': '/tools/buildbot/bin/python'} 02:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:39:07 INFO - Cleaning up... 02:39:07 INFO - Return code: 0 02:39:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:07 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 0x7ff4dc4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142e2e0>, '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 0x139a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139a5d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', '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 02:39:07 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 02:39:07 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 02:39:07 INFO - Using env: {'DISPLAY': ':0', 02:39:07 INFO - 'HOME': '/home/cltbld', 02:39:07 INFO - 'LANG': 'en_US.UTF-8', 02:39:07 INFO - 'LANGUAGE': 'en_US:en', 02:39:07 INFO - 'LOGNAME': 'cltbld', 02:39:07 INFO - 'MAIL': '/var/mail/cltbld', 02:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:07 INFO - 'MOZ_NO_REMOTE': '1', 02:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:07 INFO - 'NO_EM_RESTART': '1', 02:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:07 INFO - 'PWD': '/builds/slave/test', 02:39:07 INFO - 'SHELL': '/bin/bash', 02:39:07 INFO - 'SHLVL': '1', 02:39:07 INFO - 'TERM': 'linux', 02:39:07 INFO - 'TMOUT': '86400', 02:39:07 INFO - 'USER': 'cltbld', 02:39:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', 02:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:07 INFO - '_': '/tools/buildbot/bin/python'} 02:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:08 INFO - Downloading/unpacking flake8 02:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:39:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:39:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:39:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:39:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:39:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:39:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:39:10 INFO - no previously-included directories found matching 'docs/_build' 02:39:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:39:10 INFO - Running setup.py install for pep8 02:39:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:39:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:39:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:39:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:39:10 INFO - no previously-included directories found matching 'docs/_build' 02:39:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:39:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:39:10 INFO - Cleaning up... 02:39:11 INFO - Return code: 0 02:39:11 INFO - Running post-action listener: _resource_record_post_action 02:39:11 INFO - Running post-action listener: _start_resource_monitoring 02:39:11 INFO - Starting resource monitoring. 02:39:11 INFO - ##### 02:39:11 INFO - ##### Finished create-virtualenv step (success) 02:39:11 INFO - ##### 02:39:11 INFO - ##### 02:39:11 INFO - ##### Running install step. 02:39:11 INFO - ##### 02:39:11 INFO - Running pre-action listener: _resource_record_pre_action 02:39:11 INFO - Running main action method: install 02:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:11 INFO - Reading from file tmpfile_stdout 02:39:11 INFO - Detecting whether we're running mozinstall >=1.0... 02:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:39:11 INFO - Reading from file tmpfile_stdout 02:39:11 INFO - Output received: 02:39:11 INFO - Usage: mozinstall [options] installer 02:39:11 INFO - Options: 02:39:11 INFO - -h, --help show this help message and exit 02:39:11 INFO - -d DEST, --destination=DEST 02:39:11 INFO - Directory to install application into. [default: 02:39:11 INFO - "/builds/slave/test"] 02:39:11 INFO - --app=APP Application being installed. [default: firefox] 02:39:11 INFO - mkdir: /builds/slave/test/build/application 02:39:11 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'] 02:39:11 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 02:39:27 INFO - Reading from file tmpfile_stdout 02:39:27 INFO - Output received: 02:39:27 INFO - /builds/slave/test/build/application/firefox/firefox 02:39:27 INFO - Running post-action listener: _resource_record_post_action 02:39:27 INFO - ##### 02:39:27 INFO - ##### Finished install step (success) 02:39:27 INFO - ##### 02:39:27 INFO - ##### 02:39:27 INFO - ##### Running run-tests step. 02:39:27 INFO - ##### 02:39:27 INFO - Running pre-action listener: _resource_record_pre_action 02:39:27 INFO - Running main action method: run_tests 02:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:39:27 INFO - Python 2.7.3 02:39:27 INFO - Return code: 0 02:39:27 INFO - grabbing minidump binary from tooltool 02:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:27 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 0x142e2e0>, '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 0x139a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139a5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:39:27 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 02:39:27 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 02:39:27 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 02:39:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:39:27 INFO - Return code: 0 02:39:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:39:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:39:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:39:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:39:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:39:28 INFO - Return code: 0 02:39:28 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/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 02:39:28 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/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 02:39:28 INFO - Using env: {'DISPLAY': ':0', 02:39:28 INFO - 'HOME': '/home/cltbld', 02:39:28 INFO - 'LANG': 'en_US.UTF-8', 02:39:28 INFO - 'LANGUAGE': 'en_US:en', 02:39:28 INFO - 'LOGNAME': 'cltbld', 02:39:28 INFO - 'MAIL': '/var/mail/cltbld', 02:39:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:28 INFO - 'MOZ_NO_REMOTE': '1', 02:39:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:28 INFO - 'NO_EM_RESTART': '1', 02:39:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:28 INFO - 'PWD': '/builds/slave/test', 02:39:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:28 INFO - 'SHELL': '/bin/bash', 02:39:28 INFO - 'SHLVL': '1', 02:39:28 INFO - 'TERM': 'linux', 02:39:28 INFO - 'TMOUT': '86400', 02:39:28 INFO - 'USER': 'cltbld', 02:39:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820', 02:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:28 INFO - '_': '/tools/buildbot/bin/python'} 02:39:28 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/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 02:39:28 INFO - mozversion application_buildid: 20160613013726 02:39:28 INFO - mozversion application_changeset: 405bdbc110e121282d453fcf66cbf0daa8c3441e 02:39:28 INFO - mozversion application_display_name: Nightly 02:39:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:39:28 INFO - mozversion application_name: Firefox 02:39:28 INFO - mozversion application_remotingname: firefox 02:39:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:39:28 INFO - mozversion application_vendor: Mozilla 02:39:28 INFO - mozversion application_version: 50.0a1 02:39:28 INFO - mozversion platform_buildid: 20160613013726 02:39:28 INFO - mozversion platform_changeset: 405bdbc110e121282d453fcf66cbf0daa8c3441e 02:39:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:39:28 INFO - mozversion platform_version: 50.0a1 02:39:28 INFO - using testdate: 1465810768 02:39:28 INFO - actual date: 1465810768 02:39:28 INFO - starting webserver on 'localhost:41932' 02:39:28 INFO - SUITE-START | Running 2 tests 02:39:28 INFO - TEST-START | dromaeo_css 02:39:28 INFO - operating with platform_type : linux_ 02:39:28 INFO - Initialising browser for dromaeo_css test... 02:39:28 INFO - TEST-INFO | started process 19773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuqHOEe/profile http://localhost:41932/getInfo.html) 02:39:33 INFO - PROCESS | 19773 | __metrics Screen width/height:1600/1200 02:39:33 INFO - PROCESS | 19773 | colorDepth:24 02:39:33 INFO - PROCESS | 19773 | Browser inner width/height: 1024/697 02:39:33 INFO - PROCESS | 19773 | __metrics 02:39:34 INFO - PROCESS | 19773 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:39:34 INFO - PROCESS | 19773 | console.error: PushService: 02:39:34 INFO - PROCESS | 19773 | stateChangeProcessEnqueue: Error transitioning state 02:39:34 INFO - PROCESS | 19773 | UnknownError 02:39:35 INFO - TEST-INFO | 19773: exit 0 02:39:35 INFO - Browser initialized. 02:39:35 INFO - Running cycle 1/1 for dromaeo_css test... 02:39:35 INFO - TEST-INFO | started process 19853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuqHOEe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:47 INFO - PROCESS | 19853 | RSS: Main: 175882240 02:39:47 INFO - PROCESS | 19853 | 02:40:39 INFO - PROCESS | 19853 | 1465810839284 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] 02:42:51 INFO - PROCESS | 19853 | Cycle 1(1): loaded http://localhost:41932/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41932/tests/dromaeo/cssquery-ext.html) 02:42:52 INFO - PROCESS | 19853 | RSS: Main: 280313856 02:42:52 INFO - PROCESS | 19853 | 02:45:55 INFO - PROCESS | 19853 | Cycle 1(1): loaded http://localhost:41932/tests/dromaeo/cssquery-ext.html (next: http://localhost:41932/tests/dromaeo/cssquery-jquery.html) 02:45:55 INFO - PROCESS | 19853 | RSS: Main: 257511424 02:45:55 INFO - PROCESS | 19853 | 02:48:57 INFO - PROCESS | 19853 | Cycle 1(1): loaded http://localhost:41932/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41932/tests/dromaeo/cssquery-mootools.html) 02:48:58 INFO - PROCESS | 19853 | RSS: Main: 259186688 02:48:58 INFO - PROCESS | 19853 | 02:52:00 INFO - PROCESS | 19853 | Cycle 1(1): loaded http://localhost:41932/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41932/tests/dromaeo/cssquery-prototype.html) 02:52:01 INFO - PROCESS | 19853 | RSS: Main: 260341760 02:52:01 INFO - PROCESS | 19853 | 02:55:04 INFO - PROCESS | 19853 | Cycle 1(1): loaded http://localhost:41932/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41932/tests/dromaeo/cssquery-yui.html) 02:55:04 INFO - PROCESS | 19853 | RSS: Main: 241573888 02:55:04 INFO - PROCESS | 19853 | 02:58:08 INFO - PROCESS | 19853 | Cycle 1(1): loaded http://localhost:41932/tests/dromaeo/cssquery-yui.html (next: http://localhost:41932/tests/dromaeo/cssquery-dojo.html) 02:58:08 INFO - PROCESS | 19853 | RSS: Main: 293056512 02:58:08 INFO - PROCESS | 19853 | 02:58:08 INFO - PROCESS | 19853 | __start_tp_report 02:58:08 INFO - PROCESS | 19853 | _x_x_mozilla_page_load 02:58:08 INFO - PROCESS | 19853 | _x_x_mozilla_page_load_details 02:58:08 INFO - PROCESS | 19853 | |i|pagename|runs| 02:58:08 INFO - PROCESS | 19853 | |0;dojo.html;2557.8337408068473;2624.881880315388;2673.077788163084;2674.1843737660006;2683.8121331506804;4680.602148817355;4757.714537127775;4779.808807647694;4842.927356089657;4892.486288939659;4794.161021821176;4834.323194752728;4868.464468908417;4935.259711043345;4935.358403407561;4397.450318710169;4417.690761646686;4418.955810441887;4480.059187570614;4490.528494508078;4448.644108471331;4536.3195520672;4576.450825900896;4599.310103484488;4622.838200662977;4355.499117601453;4456;4481.350204220403;4489.214387482194;4495.078508905666;4391.692581519295;4400.295952647561;4417.359482874997;4422.71252368595;4452.220861349251;4389.034412429261;4389.626881715058;4427.933580996288;4434.17967675981;4470.128324976631;4858.927116093261;4863.2461968394955;4872.731999740013;4883.389576302962;4884.682495637772;5054.06499797535;5157.948420515821;5184.274201611777;5197.974010129963;5229.660072095302;5247;5296.073187192264;5308.601854860901;5309.070912590281;5317.601179911483;4740.525947405232;4961.305417241625;4974.77613507393;4976.576990955737;4982.327385802871;5234.162533994619;5266.894662106736;5283.233931079972;5316.415194328621;5342;5146.665466744649;5149.897002060013;5151.0470562945975;5154.433012368637;5158.845234642967;5158.896822063538;5169.844904652867;5178.844634660966;5178.922316165261;5180.9740951295;4934.062528119646;5110.1568241239775;5136.666116702402;5148.2020286855595;5150.4849515048945;5122.1804511278015;5124.333836601292;5128.948710512847;5138.07514647367;5181.844544663591;4196.433481480022;4338.7830608470085;4339.848105316362;4347.478302603708;4398.208322501981;3733.75730577517;3822.369309064029;3832.904177395532;3833.597472265372;3880.534335879656;4432.335149727567;4440.444944381952;4445.422095127613;4476.261416866246;4486.416765820422;5056.949430505648;5206.245094461282;5217;5219.399769026534;5273.472652734696;4308.073764140725;4322.394864718942;4357.106793107406;4364.127174565099;4376.759278239664;4627.259638457831;4652.302154676826;4655.441347038377;4658.697184683053;4702.764861756898;4695.577398034194;4785.353977213171;4822.084789818029;4834.371531700856;4884.340614017205;5156.535911767959;5212.687238765686;5235.65968212065;5284.233786101071;5305.469453054664;4901.803927842989;4908.582770464551;4909.165441874961;4911.877203069809;4956.677815941952;4791.496892826342;5156.9742151289;5166.4316925137455;5173.741312934413;5176.844694659167;4959.801607935642;5170.146925757208;5251.71115588631;5274.841754747364;5292.100342941786;5072.340595722532;5078.822241221539;5084.542391184811;5093.083245015932;5132.384113906355;4877.756112194305;5077.289179514797;5088.567471764942;5103.055934652101;5107.540321371094;4985.027919555652;5015.22264049073;5023.949760502348;5070.6957582545165;5090.796368145233;5130.923036154535;5132.79468821243;5133.204353325241;5134.15286477727;5183.714895680774;4853.9029219416125;4895.265710143507;5042;5045.697258164522;5100.336956195671 02:58:08 INFO - PROCESS | 19853 | |1;ext.html;552.756787013714;582.5688990147287;583.4020129367401;592.298126719837;603.7403916315982;26975.730242697566;38788.61211387885;40472.39291410631;40524.189516209655;44015.55984440155;40636.79681601588;40983.795081024626;41069;41093.58906410935;41103.79448102763;7777.844443111148;7916.129225785159;7963.362930965509;7993.720219792309;8008.479448835807;7901.683932642687;7985.5607941563485;7989.840203195932;7990.12108668046;7995.6801727930815;7970.402219833536;7992.600369981506;8007.079185893638;8010.078840933309;8010.39922005849;7933.920660793376;7994;7998.680052797881;7999.600019998977;8003.839923201504;7707.576083315415;7775.339096176832;7776.300132988002;7779.33875620573;7780.18308077655;38768.80615596904;39203.41194882079;39218.27426394488;39273;39289;3254.4142054430195;3262.7389808815237;3268.3790079884984;3686.8156592170285;3930.3711406174875;30569;30774.38451230963;31486.212844678837;32914.83542582272;33073.173170670685;3478.5303983962094;3560.3530534351084;3572.7677700949357;3619.7466177367596;3619.8371073301764;253044;258117;258421;258943;259374;57217;58399.41600584025;58488.707556461944;58569;58599.70700146472;34099;35195.472067919;35288;61111.24999375039;62291;14795.63010924714;14930.402783888523;14985.550433487013;14996.550103496913;14998;11018.50416731249;11098.55605775776;11104.333739975627;11105.888941110647;11111.444427778579;19342.132747147625;19507.101712104588;19618.215271388985;19636.509087272647;19662;7332.853342933218;7423.294786995227;7486.962565187139;7633.465657403928;7666.233376662289;810.2424233341726;850.7235148576614;876.8465518534231;929.3912487320815;940.47333493244;25920.74079259221;25981.22056338313;26905.461890762075;27193.728062719514;27229.04698335549;784.3058892879728;888.7422647432302;971.455984648599;1014.1329163565193;1017.4048181813574;13913;14073.3003133731;14134.131748419868;14201.573952781433;14298.714025719635;386905;387734;389591;392431;393500;50513;51141.48858511367;51219.74390128026;51244.74377628088;51285.23072153921;1066.5627092891878;1173.8943495085311;1204.9096317776027;1212.1090998116554;1215.6778453709774;27392.863035684695;28811;29080.27299317534;29429.26426839346;29615.555766663947;42441;42589.787051064544;42818.35772463478;42929;42988.78505607452;291199;293860;294330;295121;295510;22614.208502702328;25795.742042579335;26367.472650547264;27195.864020679768;27435.45129097367;41627;41913.79043104765;42335.36496952487;42972;43457;35603.64396356003;35980;36789.632103679694;37004.25991480209;37095;35666.286674266885;36011.45982810207;36400.27199456049;36403.27193456063;36548.45177322289;31909.68090319067;32117.839410802797;35866.28267434689;36375;36426.8178659105;30784;32071.198220044687;32623;32771;32859;24801.751982479946;25066;25211.243662690147;25657.871710641328;25672.61491077598 02:58:08 INFO - PROCESS | 19853 | |2;jquery.html;367.84366644176225;373.3224198080484;374.5748575366958;383.42869125003716;390.42802294638346;15647.295871685774;16950.91524542377;17288;17303.567410814736;17438.47684569465;16086.195690215472;16103;17193.570160745956;17198.140092995363;17199;4918.8770280743;5268.947310526884;5295.8146464873735;5308.734563271821;5309.62832601718;3732.9440058399146;3912.1979994101284;5162.6128040397125;5774.133879918004;6119.204503414549;6170.938290617104;6186;6204.47261982732;6210.565260431772;6219.533534984872;5948.226730525047;6109.266887973449;6136.325004249529;6140.416660417253;6222.595531290452;3402.4726167443837;5027.49725027498;5329.813456529042;5337;5393.541548968343;19715.309964151187;20480.795192048037;20510.79489205104;20528.281510147222;20530;1948.4252145617077;2029.2694629933212;2104.326615483046;2114.9636678027655;2242.5954145426153;12783.233006019576;13192.340382980909;13406.798898016537;13480.865191348157;13486.19082855022;1722.0270547140951;1725.6289897671936;1802.387188355952;1910.2740958435845;1924.874883132592;68516.3148368515;68925;69029.65485172592;69791.65104174498;69802.65098674526;9419.481928493862;9636.614535418645;10201.183905287558;10245.897541024495;10306.536205870603;13852.653683657787;13930.303484825718;13939.860601394059;13947.302634868216;13953.930230348986;7023.8595228095155;7059.964700176466;7202.243764404767;7220.530665506831;7475.9252407476315;6947.409470194989;7070.292970702889;7071.92928070723;7144.749933752398;7237.203907570163;3951.4665520154986;4014.2573623879675;4017.276890159741;4120.196561670446;4471.977640111843;1664.7835781348347;1772.503698964292;1813.432761422447;1841.5027942455729;1854.1934258597553;790.8102055506752;810.6149578950069;830.4311546590604;915.4873270968279;936.9344145909857;16004.439844605384;16530.58673533171;16668;17087.914560427118;17207.741883871753;814.9633266503022;843.7047033538336;858.3347905373386;869.9826003479895;878.1087196495562;9367.391119577342;9427.90572094284;9475.147236748726;9653.9034609653;9879.209663226924;400681;402025;404402;405742;410495;47910.76044619754;48575.27137092946;76665.61667191629;77855;79111;861.7285555050264;881.3610132653774;890.5947793753827;909.7816524034316;911.3984770051734;15075.396984120513;15178.696426071638;15236.3905443781;15268.968757340566;15537.922310388376;33793.49309760307;35654.465183021755;36776.816115919246;36980.81509592435;37349.81325093357;51262.74368628133;51302.486975129774;51537.48462515477;52655.73672131615;53788.73105634447;7603.429742769204;7623.69505219785;7681.6543255552515;7684.923150768421;7901.012373453318;10490.265681402228;11447.942760286145;11614.361210133524;11781.882181178422;11817.468213930566;9629.085236902483;9776.364536305118;9814.607415703578;9860.950695246478;9939.204863611038;9411.717648470556;9972.401655900669;10049;10081.193504519475;10139.949300253451;9523.428594284365;9617.519124043909;9700.369475984038;9718.271129665161;10109.545070471699;7416.666250018654;7439.330460258603;7592.924070759222;7695.4997925134685;8000.239977202156;7474.551526908403;9313.208377288007;9400.106989836228;9541.522923853918;9694.321397502106 02:58:08 INFO - PROCESS | 19853 | |3;mootools.html;1210.8062709966407;1378.0216046606906;1405.45187376923;1505.4053648808722;1728.0150314320833;6490.415862572368;7736.110347310061;7956.443048986574;7957.880631790527;8217.6302066407;7925.762227133181;8082.070561885385;8087.757367278977;8088;8092.878606820902;2255.165588732167;2278.1229226747737;2288.4050146961827;2293.20884294918;2294.036504668035;2176.793204645556;2213.6679498075255;2266.0822366941334;2271.4548508357957;2271.9886400568057;2096.297740257008;2100.4433825036376;2102.180149741602;2111.292716939827;2159.3090211132444;2169.7287839020123;2173.250228671106;2175.9564808703817;2177.2706143441887;2179.08478439056;2161.103142195987;2201.889905504718;2205.007746514059;2219.0679914435977;2222.5443784024237;7815.452918295721;8047.557384343859;8069.6368663410285;8114.431989760719;8124.796880077986;4739.336492890998;4853.708777473327;4857.951420485785;4859.368282123337;4864.829730959399;2793.7206279372103;2859.6139521164587;2882.394697113609;2920.109366643173;2931.0181089334883;876.9517676527788;887.2281115429553;892.906244844295;894.6287290774321;907.4509921497465;11004.944975275152;11079.944600277027;11091.112710983101;11172.217944743872;11172.497237624246;4040.6565441937178;4140.91718165641;4208.894777630584;4211.578842115764;4258.765767882796;8673.913260867437;8719.258862996716;8738.737837864874;8777.385583009256;8781.604827782765;4675.929861052087;4676.392069031004;4684.110019096361;4685.6017238535105;4730.929036064462;3584.946225806615;3782.7730336179916;3883.922321553553;4330.437043184429;4382.649388048949;3217.742580593547;3462.6537346265172;3477.4957631143848;3495.0563347895927;3569.4824250483534;1030.0883717909703;1068.3376306689902;1068.5191663751343;1077.4881931082673;1085.7448499602588;711.697528550364;818.7953011747063;834.3367023216557;836.0970152235572;847.588919374103;5155.639105262596;5258.631895767336;5278;5430.511253987082;5497.312835895513;410.5422453963809;417.31768558407225;417.81616088920777;420.8716341515867;441.1992234095107;3597.712183025352;3614.981925090358;3629.473726309723;3691.077230692327;3741.794201318899;9502.952485237667;10087.798244035079;10155.543000564992;10319.380837149645;10340.586376544854;10088.69733907984;10121;10130.08829205375;10131.645392411378;10136.087752102347;7430.96284518574;7432.814179645444;7639.388848892076;7650.158482566913;7670.539767613849;5282.683039017671;5306.257124002565;5316.122839731401;5403.405625381283;5449.782008719607;9487;9505.809883802423;9515.476648784383;9548.52257387114;9626.374285671409;8828.690995815115;9198.586063627286;9200.631974720936;9479.336446448959;9503.904960950578;5921.61509501881;6094;6095.908561371494;6562.409383155539;6737.124173857367;6923;6981.720731170696;7251;7455.440841936768;7477.813054673677;7062.8234294141;7172.354488096096;7210.315020073084;7296.927030729625;7369.226231245642;6968.163820341591;7020.7893763187185;7153.1416230050645;7164.068671072727;7271.454640901848;6011.098335249748;6160.168377269011;6165.691715414301;6171.753129874754;6450;4620.907581848412;4696.524571816899;4911.68074075184;4941.085899108676;4998.275250088789;4741.83403580873;4747.548982846624;4807.326974223542;4825.541573550507;5005.274235235797 02:58:08 INFO - PROCESS | 19853 | |4;prototype.html;295.4195006811616;303.85415000799617;307.95226739855326;310.0543342804446;315.13338319621045;4733.384659994204;4770.928436073457;4843.903121937568;4866.85399438017;4892.14387482191;4628.62970962323;4789.677006651771;4790.5448982346625;4822.204336284509;4824.807007719687;3835.328817456948;3838.366669499529;3845.442410850425;3846.4230365445196;3884.8834534964;3648.179159689062;3694.224212915278;3850.942235866464;3864.574896761354;3867.477890484791;3773.8490460381554;3832.482614847002;3839.6544311012003;3849.9807500962456;3851.268259030775;3798.2783271178528;3802.0684932191652;3815.656590906804;3827.119762454623;3850.7497012694366;3403.4554471284723;3413.634546181547;3417.128632198798;3425.383430982422;3427.1260828488826;4622.884427889296;4670.416197975253;4671.159191345557;4687.835925742616;4689.273162659793;4323.746113627044;4332.91334173318;4335.306350983859;4348.73907565544;4354.303311470181;4997.4258108696;5031.597472202215;5031.924521132186;5038.949610503884;5043.722595257259;3554.9466757998653;3702.6667599916136;3707.5169932027134;3716.7955762433326;3728.6271372862766;5198.194279886586;5207.166853303491;5244.921326180111;5247.658902171346;5261.947380526184;3792.4500947362476;3798.3542797724454;3806.467094606757;3808.2383523295453;3815.542134943769;3569.6430356964615;3862.1503269280715;3863.5943225961432;3864.768113913174;3888.4361767544115;4182.749035057906;4243.618074373321;4245.766482843412;4265.338872474771;4265.893352666146;4951.851444456672;4953.281774142729;5006.199008158677;5022.748862556858;5068.746562671926;1239.7458521003173;1265.1207410849556;1295.8185853980451;1305.8759417855288;1311.475409836054;824.2705205892709;824.7979245084873;832.825106727594;835.2023817254508;838.4550042472441;3969.7419667721506;3987.8205480753436;3995.9800200998807;4025.215083058834;4036.4752582164133;4687.742174180453;4696.624270058387;4714.646401519831;4715.976420117878;4730.361401210861;3957.1689945111275;3982.601739825994;3986.8405263789705;4001.199760048002;4004.9399259010556;2362.7991620712087;2406.57884870147;2414.6136618141013;2453.6196889482158;2462.6429167770575;4347.5217726050105;4393.6704747144095;4395.604395604411;4399;4439.600435960714;4766;4782.808687652455;4783.736894470768;4807.567318941312;4808.735519546459;4195.30777421722;4351.477822661301;4410.338449232577;4471.8434854779925;4476.462824461086;4719.032598317405;4724.763761811827;4735.550122738335;4735.763211839326;4754.881127971828;4637.513061128668;4667.74327411982;4670.64970127235;4683.718976861399;4688.859334219979;4178.979105104455;4391.714538554984;4397.372972000252;4462.799174037111;4492.865214043584;3358.4794356874722;3420.880269190666;3433.656634336546;3434.553508043938;3441.896743097711;4648.233671204921;4662.65030122749;4683.297505374085;4711.798491384675;5003.54968052877;4895.828645997373;4989.650724449254;5037.546620804145;5059.494050594911;5100.821471248489;5067.543921047123;5076.390833100052;5076.416212135652;5092.439831618593;5096.566791822736;4737.147313483606;4924.82763103304;5004.749762511787;5015.824446144367;5032.899342013213;5050.419201791841;5058.26655134996;5080.898382032413;5091.66904151229;5092.9745351273;4921.9015619688125;4944.629152813482;4972.726500042532;4985;5026.698398096126 02:58:08 INFO - PROCESS | 19853 | |5;yui.html;662.9171353580803;664.0835646807411;673.4208580620667;679.7926632377123;688.6763221285995;11765.764684706312;12738.108332416734;13037.087403881733;13241.602751917433;13328.266945318004;12252.387380630977;13523.526676566322;13954.372053257603;13966.860331396683;14572.927135364334;622.1290193728771;764.4572353628903;792.2117493094365;792.4096548071694;795.1094773853292;776.1384862802284;798.2456578533288;799.2247519905682;799.5162926429514;799.7960520067375;843.9704610338639;850.37497439382;850.6682393866397;850.7150104714897;851.0553285852699;642.0561774191931;808.5876203136384;821.650798410673;842.7261140129483;843.6920524008754;614.5820841827556;614.7817524778728;614.8493619063313;615.0405367626516;615.59986009094;12410.503579856795;12461.252324860538;12540.874591254062;12570.245785252913;12611.117221794479;10734.194935379877;11277.097832173406;11303.604373846876;11357.318560886291;11636.825447618292;10609.84085238722;10772.892271077268;10802.297850639683;10836.07893329068;10866.565337386495;3983.940240896389;4019.336809426441;4035.4955630546183;4039.4950631171105;4137.97931010346;53239.733801330745;55419.722901385234;55451.72274138644;57809.132863007086;63994.68002659957;9104.635814567344;9332.44005359667;9805.313628045968;10176.694699159038;10379.325343852626;17797.644047119244;17961.281548737905;17964.820351796578;17984;18092.36676716335;7009.824754381181;7018.508704390643;7166.856662866713;7216.3505284524645;7358.668859901317;3776.5090538229856;3872.5740168581433;3935.0752573145287;3956.8812935611977;4072.185562887375;2907.6656184538624;3037.39252149571;3037.8177309361067;3039.4377040247623;3040.8935687251283;504.0825697231078;513.5224241455408;523.3118449239314;524.727141886217;538.3432212700499;461.4854437302384;508.9540993258889;529.9390570084413;556.4213218253052;580.7299605683293;6812.216595091529;7151.7854464366155;7205.171405288354;7291.9270807292305;7492.625368731542;506.62762869291043;536.6806749983831;541.5667466027163;546.8359492152339;558.8658721906713;3173.3335999439914;3312.850921708529;3408.9602671185526;3536.3457760314423;3627.111357717376;51782.74108629508;90491;95265;95590.52204738931;96888;46357;48271.5172848274;48431.273530897066;82299.5885020571;83047.16952830394;50598.74700626473;66101.6694916532;67864.3213567868;72238;73253.26746732571;7481;7516.323530882247;7528.4353673473615;7602.391808655184;7685.730999414994;37902.62097378991;39177;39193;40244.59755402408;40255;39950.80024599859;43104.35343469913;53225.46774532205;60302.396976029675;63582;10230.437325947145;10448.843267350843;10496.025358460724;10734.73163170927;10915.290506117077;11885.049196064121;11898.515294257835;12266.570670026505;12349.073819463756;12383.380830958597;10504.159667226451;10707.357558546511;10776.29954052984;11047.337159770439;11081.390523521284;9607.903920960702;9957.302988791005;10069.144122749649;10287.43419111956;10332.121769649664;11228.214025018171;11409.543618255177;11414.714632134263;11492.032356015356;11792.29246245228;8752.606132723915;8808.95595522044;8809.603567839335;9087.727368178965;9214.216791572791;8868.733937981871;8898.510581918057;9159.122379911969;9182.770430739285;9199.77000574991 02:58:08 INFO - PROCESS | 19853 | __end_tp_report 02:58:08 INFO - PROCESS | 19853 | __start_cc_report 02:58:08 INFO - PROCESS | 19853 | _x_x_mozilla_cycle_collect,988 02:58:08 INFO - PROCESS | 19853 | __end_cc_report 02:58:08 INFO - PROCESS | 19853 | __startTimestamp1465811888361__endTimestamp 02:58:08 INFO - PROCESS | 19853 | 02:58:08 INFO - PROCESS | 19853 | ------- Summary: start ------- 02:58:08 INFO - PROCESS | 19853 | Number of tests: 6 02:58:08 INFO - PROCESS | 19853 | 02:58:08 INFO - PROCESS | 19853 | [#0] dojo.html Cycles:165 Average:4789.80 Median:4934.06 stddev:522.77 (10.6%) stddev-sans-first:494.18 02:58:08 INFO - PROCESS | 19853 | Values: 2557.8 2624.9 2673.1 2674.2 2683.8 4680.6 4757.7 4779.8 4842.9 4892.5 4794.2 4834.3 4868.5 4935.3 4935.4 4397.5 4417.7 4419.0 4480.1 4490.5 4448.6 4536.3 4576.5 4599.3 4622.8 4355.5 4456.0 4481.4 4489.2 4495.1 4391.7 4400.3 4417.4 4422.7 4452.2 4389.0 4389.6 4427.9 4434.2 4470.1 4858.9 4863.2 4872.7 4883.4 4884.7 5054.1 5157.9 5184.3 5198.0 5229.7 5247.0 5296.1 5308.6 5309.1 5317.6 4740.5 4961.3 4974.8 4976.6 4982.3 5234.2 5266.9 5283.2 5316.4 5342.0 5146.7 5149.9 5151.0 5154.4 5158.8 5158.9 5169.8 5178.8 5178.9 5181.0 4934.1 5110.2 5136.7 5148.2 5150.5 5122.2 5124.3 5128.9 5138.1 5181.8 4196.4 4338.8 4339.8 4347.5 4398.2 3733.8 3822.4 3832.9 3833.6 3880.5 4432.3 4440.4 4445.4 4476.3 4486.4 5056.9 5206.2 5217.0 5219.4 5273.5 4308.1 4322.4 4357.1 4364.1 4376.8 4627.3 4652.3 4655.4 4658.7 4702.8 4695.6 4785.4 4822.1 4834.4 4884.3 5156.5 5212.7 5235.7 5284.2 5305.5 4901.8 4908.6 4909.2 4911.9 4956.7 4791.5 5157.0 5166.4 5173.7 5176.8 4959.8 5170.1 5251.7 5274.8 5292.1 5072.3 5078.8 5084.5 5093.1 5132.4 4877.8 5077.3 5088.6 5103.1 5107.5 4985.0 5015.2 5023.9 5070.7 5090.8 5130.9 5132.8 5133.2 5134.2 5183.7 4853.9 4895.3 5042.0 5045.7 5100.3 02:58:08 INFO - PROCESS | 19853 | 02:58:08 INFO - PROCESS | 19853 | [#1] ext.html Cycles:180 Average:47095.52 Median:36669.04 stddev:83855.95 (228.7%) stddev-sans-first:84018.37 02:58:08 INFO - PROCESS | 19853 | Values: 552.8 582.6 583.4 592.3 603.7 26975.7 38788.6 40472.4 40524.2 44015.6 40636.8 40983.8 41069.0 41093.6 41103.8 7777.8 7916.1 7963.4 7993.7 8008.5 7901.7 7985.6 7989.8 7990.1 7995.7 7970.4 7992.6 8007.1 8010.1 8010.4 7933.9 7994.0 7998.7 7999.6 8003.8 7707.6 7775.3 7776.3 7779.3 7780.2 38768.8 39203.4 39218.3 39273.0 39289.0 3254.4 3262.7 3268.4 3686.8 3930.4 30569.0 30774.4 31486.2 32914.8 33073.2 3478.5 3560.4 3572.8 3619.7 3619.8 253044.0 258117.0 258421.0 258943.0 259374.0 57217.0 58399.4 58488.7 58569.0 58599.7 34099.0 35195.5 35288.0 61111.2 62291.0 14795.6 14930.4 14985.6 14996.6 14998.0 11018.5 11098.6 11104.3 11105.9 11111.4 19342.1 19507.1 19618.2 19636.5 19662.0 7332.9 7423.3 7487.0 7633.5 7666.2 810.2 850.7 876.8 929.4 940.5 25920.7 25981.2 26905.5 27193.7 27229.0 784.3 888.7 971.5 1014.1 1017.4 13913.0 14073.3 14134.1 14201.6 14298.7 386905.0 387734.0 389591.0 392431.0 393500.0 50513.0 51141.5 51219.7 51244.7 51285.2 1066.6 1173.9 1204.9 1212.1 1215.7 27392.9 28811.0 29080.3 29429.3 29615.6 42441.0 42589.8 42818.4 42929.0 42988.8 291199.0 293860.0 294330.0 295121.0 295510.0 22614.2 25795.7 26367.5 27195.9 27435.5 41627.0 41913.8 42335.4 42972.0 43457.0 35603.6 35980.0 36789.6 37004.3 37095.0 35666.3 36011.5 36400.3 36403.3 36548.5 31909.7 32117.8 35866.3 36375.0 36426.8 30784.0 32071.2 32623.0 32771.0 32859.0 24801.8 25066.0 25211.2 25657.9 25672.6 02:58:08 INFO - PROCESS | 19853 | 02:58:08 INFO - PROCESS | 19853 | [#2] jquery.html Cycles:180 Average:24461.01 Median:51419.99 stddev:66553.90 (129.4%) stddev-sans-first:66716.02 02:58:08 INFO - PROCESS | 19853 | Values: 367.8 373.3 374.6 383.4 390.4 15647.3 16950.9 17288.0 17303.6 17438.5 16086.2 16103.0 17193.6 17198.1 17199.0 4918.9 5268.9 5295.8 5308.7 5309.6 3732.9 3912.2 5162.6 5774.1 6119.2 6170.9 6186.0 6204.5 6210.6 6219.5 5948.2 6109.3 6136.3 6140.4 6222.6 3402.5 5027.5 5329.8 5337.0 5393.5 19715.3 20480.8 20510.8 20528.3 20530.0 1948.4 2029.3 2104.3 2115.0 2242.6 12783.2 13192.3 13406.8 13480.9 13486.2 1722.0 1725.6 1802.4 1910.3 1924.9 68516.3 68925.0 69029.7 69791.7 69802.7 9419.5 9636.6 10201.2 10245.9 10306.5 13852.7 13930.3 13939.9 13947.3 13953.9 7023.9 7060.0 7202.2 7220.5 7475.9 6947.4 7070.3 7071.9 7144.7 7237.2 3951.5 4014.3 4017.3 4120.2 4472.0 1664.8 1772.5 1813.4 1841.5 1854.2 790.8 810.6 830.4 915.5 936.9 16004.4 16530.6 16668.0 17087.9 17207.7 815.0 843.7 858.3 870.0 878.1 9367.4 9427.9 9475.1 9653.9 9879.2 400681.0 402025.0 404402.0 405742.0 410495.0 47910.8 48575.3 76665.6 77855.0 79111.0 861.7 881.4 890.6 909.8 911.4 15075.4 15178.7 15236.4 15269.0 15537.9 33793.5 35654.5 36776.8 36980.8 37349.8 51262.7 51302.5 51537.5 52655.7 53788.7 7603.4 7623.7 7681.7 7684.9 7901.0 10490.3 11447.9 11614.4 11781.9 11817.5 9629.1 9776.4 9814.6 9861.0 9939.2 9411.7 9972.4 10049.0 10081.2 10139.9 9523.4 9617.5 9700.4 9718.3 10109.5 7416.7 7439.3 7592.9 7695.5 8000.2 7474.6 9313.2 9400.1 9541.5 9694.3 02:58:08 INFO - PROCESS | 19853 | 02:58:08 INFO - PROCESS | 19853 | [#3] mootools.html Cycles:180 Average:5217.49 Median:4839.63 stddev:3009.65 (62.2%) stddev-sans-first:3003.03 02:58:08 INFO - PROCESS | 19853 | Values: 1210.8 1378.0 1405.5 1505.4 1728.0 6490.4 7736.1 7956.4 7957.9 8217.6 7925.8 8082.1 8087.8 8088.0 8092.9 2255.2 2278.1 2288.4 2293.2 2294.0 2176.8 2213.7 2266.1 2271.5 2272.0 2096.3 2100.4 2102.2 2111.3 2159.3 2169.7 2173.3 2176.0 2177.3 2179.1 2161.1 2201.9 2205.0 2219.1 2222.5 7815.5 8047.6 8069.6 8114.4 8124.8 4739.3 4853.7 4858.0 4859.4 4864.8 2793.7 2859.6 2882.4 2920.1 2931.0 877.0 887.2 892.9 894.6 907.5 11004.9 11079.9 11091.1 11172.2 11172.5 4040.7 4140.9 4208.9 4211.6 4258.8 8673.9 8719.3 8738.7 8777.4 8781.6 4675.9 4676.4 4684.1 4685.6 4730.9 3584.9 3782.8 3883.9 4330.4 4382.6 3217.7 3462.7 3477.5 3495.1 3569.5 1030.1 1068.3 1068.5 1077.5 1085.7 711.7 818.8 834.3 836.1 847.6 5155.6 5258.6 5278.0 5430.5 5497.3 410.5 417.3 417.8 420.9 441.2 3597.7 3615.0 3629.5 3691.1 3741.8 9503.0 10087.8 10155.5 10319.4 10340.6 10088.7 10121.0 10130.1 10131.6 10136.1 7431.0 7432.8 7639.4 7650.2 7670.5 5282.7 5306.3 5316.1 5403.4 5449.8 9487.0 9505.8 9515.5 9548.5 9626.4 8828.7 9198.6 9200.6 9479.3 9503.9 5921.6 6094.0 6095.9 6562.4 6737.1 6923.0 6981.7 7251.0 7455.4 7477.8 7062.8 7172.4 7210.3 7296.9 7369.2 6968.2 7020.8 7153.1 7164.1 7271.5 6011.1 6160.2 6165.7 6171.8 6450.0 4620.9 4696.5 4911.7 4941.1 4998.3 4741.8 4747.5 4807.3 4825.5 5005.3 02:58:08 INFO - PROCESS | 19853 | 02:58:08 INFO - PROCESS | 19853 | [#4] prototype.html Cycles:180 Average:4062.21 Median:4451.20 stddev:1161.31 (26.1%) stddev-sans-first:1129.63 02:58:08 INFO - PROCESS | 19853 | Values: 295.4 303.9 308.0 310.1 315.1 4733.4 4770.9 4843.9 4866.9 4892.1 4628.6 4789.7 4790.5 4822.2 4824.8 3835.3 3838.4 3845.4 3846.4 3884.9 3648.2 3694.2 3850.9 3864.6 3867.5 3773.8 3832.5 3839.7 3850.0 3851.3 3798.3 3802.1 3815.7 3827.1 3850.7 3403.5 3413.6 3417.1 3425.4 3427.1 4622.9 4670.4 4671.2 4687.8 4689.3 4323.7 4332.9 4335.3 4348.7 4354.3 4997.4 5031.6 5031.9 5038.9 5043.7 3554.9 3702.7 3707.5 3716.8 3728.6 5198.2 5207.2 5244.9 5247.7 5261.9 3792.5 3798.4 3806.5 3808.2 3815.5 3569.6 3862.2 3863.6 3864.8 3888.4 4182.7 4243.6 4245.8 4265.3 4265.9 4951.9 4953.3 5006.2 5022.7 5068.7 1239.7 1265.1 1295.8 1305.9 1311.5 824.3 824.8 832.8 835.2 838.5 3969.7 3987.8 3996.0 4025.2 4036.5 4687.7 4696.6 4714.6 4716.0 4730.4 3957.2 3982.6 3986.8 4001.2 4004.9 2362.8 2406.6 2414.6 2453.6 2462.6 4347.5 4393.7 4395.6 4399.0 4439.6 4766.0 4782.8 4783.7 4807.6 4808.7 4195.3 4351.5 4410.3 4471.8 4476.5 4719.0 4724.8 4735.6 4735.8 4754.9 4637.5 4667.7 4670.6 4683.7 4688.9 4179.0 4391.7 4397.4 4462.8 4492.9 3358.5 3420.9 3433.7 3434.6 3441.9 4648.2 4662.7 4683.3 4711.8 5003.5 4895.8 4989.7 5037.5 5059.5 5100.8 5067.5 5076.4 5076.4 5092.4 5096.6 4737.1 4924.8 5004.7 5015.8 5032.9 5050.4 5058.3 5080.9 5091.7 5093.0 4921.9 4944.6 4972.7 4985.0 5026.7 02:58:08 INFO - PROCESS | 19853 | 02:58:08 INFO - PROCESS | 19853 | [#5] yui.html Cycles:180 Average:15734.49 Median:26148.13 stddev:21847.87 (83.6%) stddev-sans-first:21879.85 02:58:08 INFO - PROCESS | 19853 | Values: 662.9 664.1 673.4 679.8 688.7 11765.8 12738.1 13037.1 13241.6 13328.3 12252.4 13523.5 13954.4 13966.9 14572.9 622.1 764.5 792.2 792.4 795.1 776.1 798.2 799.2 799.5 799.8 844.0 850.4 850.7 850.7 851.1 642.1 808.6 821.7 842.7 843.7 614.6 614.8 614.8 615.0 615.6 12410.5 12461.3 12540.9 12570.2 12611.1 10734.2 11277.1 11303.6 11357.3 11636.8 10609.8 10772.9 10802.3 10836.1 10866.6 3983.9 4019.3 4035.5 4039.5 4138.0 53239.7 55419.7 55451.7 57809.1 63994.7 9104.6 9332.4 9805.3 10176.7 10379.3 17797.6 17961.3 17964.8 17984.0 18092.4 7009.8 7018.5 7166.9 7216.4 7358.7 3776.5 3872.6 3935.1 3956.9 4072.2 2907.7 3037.4 3037.8 3039.4 3040.9 504.1 513.5 523.3 524.7 538.3 461.5 509.0 529.9 556.4 580.7 6812.2 7151.8 7205.2 7291.9 7492.6 506.6 536.7 541.6 546.8 558.9 3173.3 3312.9 3409.0 3536.3 3627.1 51782.7 90491.0 95265.0 95590.5 96888.0 46357.0 48271.5 48431.3 82299.6 83047.2 50598.7 66101.7 67864.3 72238.0 73253.3 7481.0 7516.3 7528.4 7602.4 7685.7 37902.6 39177.0 39193.0 40244.6 40255.0 39950.8 43104.4 53225.5 60302.4 63582.0 10230.4 10448.8 10496.0 10734.7 10915.3 11885.0 11898.5 12266.6 12349.1 12383.4 10504.2 10707.4 10776.3 11047.3 11081.4 9607.9 9957.3 10069.1 10287.4 10332.1 11228.2 11409.5 11414.7 11492.0 11792.3 8752.6 8809.0 8809.6 9087.7 9214.2 8868.7 8898.5 9159.1 9182.8 9199.8 02:58:08 INFO - PROCESS | 19853 | -------- Summary: end -------- 02:58:08 INFO - PROCESS | 19853 | 02:58:09 INFO - TEST-INFO | 19853: exit 0 02:58:09 INFO - TEST-OK | dromaeo_css | took 1120568ms 02:58:09 INFO - TEST-START | kraken 02:58:09 INFO - operating with platform_type : linux_ 02:58:09 INFO - Initialising browser for kraken test... 02:58:09 INFO - TEST-INFO | started process 20033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG1CibL/profile http://localhost:41932/getInfo.html) 02:58:13 INFO - PROCESS | 20033 | __metrics Screen width/height:1600/1200 02:58:13 INFO - PROCESS | 20033 | colorDepth:24 02:58:13 INFO - PROCESS | 20033 | Browser inner width/height: 1024/697 02:58:13 INFO - PROCESS | 20033 | __metrics 02:58:14 INFO - PROCESS | 20033 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:58:14 INFO - PROCESS | 20033 | console.error: PushService: 02:58:14 INFO - PROCESS | 20033 | stateChangeProcessEnqueue: Error transitioning state 02:58:14 INFO - PROCESS | 20033 | UnknownError 02:58:15 INFO - TEST-INFO | 20033: exit 0 02:58:15 INFO - Browser initialized. 02:58:15 INFO - Running cycle 1/1 for kraken test... 02:58:15 INFO - TEST-INFO | started process 20111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG1CibL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:27 INFO - PROCESS | 20111 | RSS: Main: 175669248 02:58:27 INFO - PROCESS | 20111 | 02:58:30 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41932/tests/kraken/driver.html?testName=audio-beat-detection) 02:58:31 INFO - PROCESS | 20111 | RSS: Main: 233123840 02:58:31 INFO - PROCESS | 20111 | 02:58:34 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41932/tests/kraken/driver.html?testName=audio-dft) 02:58:34 INFO - PROCESS | 20111 | RSS: Main: 220434432 02:58:34 INFO - PROCESS | 20111 | 02:58:38 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41932/tests/kraken/driver.html?testName=audio-fft) 02:58:38 INFO - PROCESS | 20111 | RSS: Main: 289394688 02:58:38 INFO - PROCESS | 20111 | 02:58:40 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41932/tests/kraken/driver.html?testName=audio-oscillator) 02:58:41 INFO - PROCESS | 20111 | RSS: Main: 198983680 02:58:41 INFO - PROCESS | 20111 | 02:58:43 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41932/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:58:44 INFO - PROCESS | 20111 | RSS: Main: 202153984 02:58:44 INFO - PROCESS | 20111 | 02:58:47 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41932/tests/kraken/driver.html?testName=imaging-darkroom) 02:58:48 INFO - PROCESS | 20111 | RSS: Main: 239505408 02:58:48 INFO - PROCESS | 20111 | 02:58:51 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41932/tests/kraken/driver.html?testName=imaging-desaturate) 02:58:52 INFO - PROCESS | 20111 | RSS: Main: 240459776 02:58:52 INFO - PROCESS | 20111 | 02:58:55 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41932/tests/kraken/driver.html?testName=json-parse-financial) 02:58:55 INFO - PROCESS | 20111 | RSS: Main: 240082944 02:58:55 INFO - PROCESS | 20111 | 02:58:57 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41932/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:58:58 INFO - PROCESS | 20111 | RSS: Main: 224473088 02:58:58 INFO - PROCESS | 20111 | 02:58:59 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41932/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:59:00 INFO - PROCESS | 20111 | RSS: Main: 230703104 02:59:00 INFO - PROCESS | 20111 | 02:59:02 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41932/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:59:03 INFO - PROCESS | 20111 | RSS: Main: 237199360 02:59:03 INFO - PROCESS | 20111 | 02:59:06 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:59:06 INFO - PROCESS | 20111 | RSS: Main: 241074176 02:59:06 INFO - PROCESS | 20111 | 02:59:09 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:10 INFO - PROCESS | 20111 | RSS: Main: 239788032 02:59:10 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | Cycle 1(1): loaded http://localhost:41932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41932/tests/kraken/driver.html?testName=ai-astar) 02:59:12 INFO - PROCESS | 20111 | RSS: Main: 282189824 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | __start_tp_report 02:59:12 INFO - PROCESS | 20111 | _x_x_mozilla_page_load 02:59:12 INFO - PROCESS | 20111 | _x_x_mozilla_page_load_details 02:59:12 INFO - PROCESS | 20111 | |i|pagename|runs| 02:59:12 INFO - PROCESS | 20111 | |0;ai-astar;111;109;113;112;113;112;113;113;112;111 02:59:12 INFO - PROCESS | 20111 | |1;audio-beat-detection;163;130;135;182;129;170;163;132;198;129 02:59:12 INFO - PROCESS | 20111 | |2;audio-dft;163;162;162;162;163;161;162;161;161;159 02:59:12 INFO - PROCESS | 20111 | |3;audio-fft;76;74;74;129;75;76;73;75;97;76 02:59:12 INFO - PROCESS | 20111 | |4;audio-oscillator;85;95;111;85;86;86;124;85;86;126 02:59:12 INFO - PROCESS | 20111 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;118;117;117 02:59:12 INFO - PROCESS | 20111 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;146 02:59:12 INFO - PROCESS | 20111 | |7;imaging-desaturate;96;95;96;96;96;96;95;96;94;94 02:59:12 INFO - PROCESS | 20111 | |8;json-parse-financial;63;62;62;60;63;63;63;61;62;62 02:59:12 INFO - PROCESS | 20111 | |9;json-stringify-tinderbox;66;65;65;65;65;66;65;67;66;66 02:59:12 INFO - PROCESS | 20111 | |10;stanford-crypto-aes;83;84;83;84;83;85;93;99;124;89 02:59:12 INFO - PROCESS | 20111 | |11;stanford-crypto-ccm;142;130;139;129;129;130;131;129;144;132 02:59:12 INFO - PROCESS | 20111 | |12;stanford-crypto-pbkdf2;176;170;169;173;171;171;169;172;171;170 02:59:12 INFO - PROCESS | 20111 | |13;stanford-crypto-sha256-iterative;67;67;71;67;67;67;67;71;67;65 02:59:12 INFO - PROCESS | 20111 | __end_tp_report 02:59:12 INFO - PROCESS | 20111 | __start_cc_report 02:59:12 INFO - PROCESS | 20111 | _x_x_mozilla_cycle_collect,1903 02:59:12 INFO - PROCESS | 20111 | __end_cc_report 02:59:12 INFO - PROCESS | 20111 | __startTimestamp1465811952373__endTimestamp 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | ------- Summary: start ------- 02:59:12 INFO - PROCESS | 20111 | Number of tests: 14 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:1.29 (1.1%) stddev-sans-first:1.32 02:59:12 INFO - PROCESS | 20111 | Values: 111.0 109.0 113.0 112.0 113.0 112.0 113.0 113.0 112.0 111.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:163.00 stddev:25.39 (15.6%) stddev-sans-first:26.67 02:59:12 INFO - PROCESS | 20111 | Values: 163.0 130.0 135.0 182.0 129.0 170.0 163.0 132.0 198.0 129.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.13 02:59:12 INFO - PROCESS | 20111 | Values: 163.0 162.0 162.0 162.0 163.0 161.0 162.0 161.0 161.0 159.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.50 stddev:17.78 (23.6%) stddev-sans-first:18.71 02:59:12 INFO - PROCESS | 20111 | Values: 76.0 74.0 74.0 129.0 75.0 76.0 73.0 75.0 97.0 76.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.50 stddev:16.88 (19.7%) stddev-sans-first:17.35 02:59:12 INFO - PROCESS | 20111 | Values: 85.0 95.0 111.0 85.0 86.0 86.0 124.0 85.0 86.0 126.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 02:59:12 INFO - PROCESS | 20111 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 118.0 117.0 117.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 02:59:12 INFO - PROCESS | 20111 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 02:59:12 INFO - PROCESS | 20111 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 94.0 94.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:62.50 stddev:0.99 (1.6%) stddev-sans-first:1.00 02:59:12 INFO - PROCESS | 20111 | Values: 63.0 62.0 62.0 60.0 63.0 63.0 63.0 61.0 62.0 62.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 02:59:12 INFO - PROCESS | 20111 | Values: 66.0 65.0 65.0 65.0 65.0 66.0 65.0 67.0 66.0 66.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:84.50 stddev:12.85 (15.2%) stddev-sans-first:13.32 02:59:12 INFO - PROCESS | 20111 | Values: 83.0 84.0 83.0 84.0 83.0 85.0 93.0 99.0 124.0 89.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:131.50 stddev:5.84 (4.4%) stddev-sans-first:5.32 02:59:12 INFO - PROCESS | 20111 | Values: 142.0 130.0 139.0 129.0 129.0 130.0 131.0 129.0 144.0 132.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:171.00 stddev:2.10 (1.2%) stddev-sans-first:1.32 02:59:12 INFO - PROCESS | 20111 | Values: 176.0 170.0 169.0 173.0 171.0 171.0 169.0 172.0 171.0 170.0 02:59:12 INFO - PROCESS | 20111 | 02:59:12 INFO - PROCESS | 20111 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:1.90 (2.8%) stddev-sans-first:2.00 02:59:12 INFO - PROCESS | 20111 | Values: 67.0 67.0 71.0 67.0 67.0 67.0 67.0 71.0 67.0 65.0 02:59:12 INFO - PROCESS | 20111 | -------- Summary: end -------- 02:59:12 INFO - PROCESS | 20111 | 02:59:13 INFO - TEST-INFO | 20111: exit 0 02:59:13 INFO - TEST-OK | kraken | took 64235ms 02:59:13 INFO - SUITE-END | took 1184s 02:59:13 INFO - Completed test suite (00:19:44) 02:59:13 INFO - javascript benchmark 02:59:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2557.8337408068473, 2624.881880315388, 2673.077788163084, 2674.1843737660006, 2683.8121331506804, 4680.602148817355, 4757.714537127775, 4779.808807647694, 4842.927356089657, 4892.486288939659, 4794.161021821176, 4834.323194752728, 4868.464468908417, 4935.259711043345, 4935.358403407561, 4397.450318710169, 4417.690761646686, 4418.955810441887, 4480.059187570614, 4490.528494508078, 4448.644108471331, 4536.3195520672, 4576.450825900896, 4599.310103484488, 4622.838200662977, 4355.499117601453, 4456.0, 4481.350204220403, 4489.214387482194, 4495.078508905666, 4391.692581519295, 4400.295952647561, 4417.359482874997, 4422.71252368595, 4452.220861349251, 4389.034412429261, 4389.626881715058, 4427.933580996288, 4434.17967675981, 4470.128324976631, 4858.927116093261, 4863.2461968394955, 4872.731999740013, 4883.389576302962, 4884.682495637772, 5054.06499797535, 5157.948420515821, 5184.274201611777, 5197.974010129963, 5229.660072095302, 5247.0, 5296.073187192264, 5308.601854860901, 5309.070912590281, 5317.601179911483, 4740.525947405232, 4961.305417241625, 4974.77613507393, 4976.576990955737, 4982.327385802871, 5234.162533994619, 5266.894662106736, 5283.233931079972, 5316.415194328621, 5342.0, 5146.665466744649, 5149.897002060013, 5151.0470562945975, 5154.433012368637, 5158.845234642967, 5158.896822063538, 5169.844904652867, 5178.844634660966, 5178.922316165261, 5180.9740951295, 4934.062528119646, 5110.1568241239775, 5136.666116702402, 5148.2020286855595, 5150.4849515048945, 5122.1804511278015, 5124.333836601292, 5128.948710512847, 5138.07514647367, 5181.844544663591, 4196.433481480022, 4338.7830608470085, 4339.848105316362, 4347.478302603708, 4398.208322501981, 3733.75730577517, 3822.369309064029, 3832.904177395532, 3833.597472265372, 3880.534335879656, 4432.335149727567, 4440.444944381952, 4445.422095127613, 4476.261416866246, 4486.416765820422, 5056.949430505648, 5206.245094461282, 5217.0, 5219.399769026534, 5273.472652734696, 4308.073764140725, 4322.394864718942, 4357.106793107406, 4364.127174565099, 4376.759278239664, 4627.259638457831, 4652.302154676826, 4655.441347038377, 4658.697184683053, 4702.764861756898, 4695.577398034194, 4785.353977213171, 4822.084789818029, 4834.371531700856, 4884.340614017205, 5156.535911767959, 5212.687238765686, 5235.65968212065, 5284.233786101071, 5305.469453054664, 4901.803927842989, 4908.582770464551, 4909.165441874961, 4911.877203069809, 4956.677815941952, 4791.496892826342, 5156.9742151289, 5166.4316925137455, 5173.741312934413, 5176.844694659167, 4959.801607935642, 5170.146925757208, 5251.71115588631, 5274.841754747364, 5292.100342941786, 5072.340595722532, 5078.822241221539, 5084.542391184811, 5093.083245015932, 5132.384113906355, 4877.756112194305, 5077.289179514797, 5088.567471764942, 5103.055934652101, 5107.540321371094, 4985.027919555652, 5015.22264049073, 5023.949760502348, 5070.6957582545165, 5090.796368145233, 5130.923036154535, 5132.79468821243, 5133.204353325241, 5134.15286477727, 5183.714895680774, 4853.9029219416125, 4895.265710143507, 5042.0, 5045.697258164522, 5100.336956195671], "value": 4754.9679241889935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.756787013714, 582.5688990147287, 583.4020129367401, 592.298126719837, 603.7403916315982, 26975.730242697566, 38788.61211387885, 40472.39291410631, 40524.189516209655, 44015.55984440155, 40636.79681601588, 40983.795081024626, 41069.0, 41093.58906410935, 41103.79448102763, 7777.844443111148, 7916.129225785159, 7963.362930965509, 7993.720219792309, 8008.479448835807, 7901.683932642687, 7985.5607941563485, 7989.840203195932, 7990.12108668046, 7995.6801727930815, 7970.402219833536, 7992.600369981506, 8007.079185893638, 8010.078840933309, 8010.39922005849, 7933.920660793376, 7994.0, 7998.680052797881, 7999.600019998977, 8003.839923201504, 7707.576083315415, 7775.339096176832, 7776.300132988002, 7779.33875620573, 7780.18308077655, 38768.80615596904, 39203.41194882079, 39218.27426394488, 39273.0, 39289.0, 3254.4142054430195, 3262.7389808815237, 3268.3790079884984, 3686.8156592170285, 3930.3711406174875, 30569.0, 30774.38451230963, 31486.212844678837, 32914.83542582272, 33073.173170670685, 3478.5303983962094, 3560.3530534351084, 3572.7677700949357, 3619.7466177367596, 3619.8371073301764, 253044.0, 258117.0, 258421.0, 258943.0, 259374.0, 57217.0, 58399.41600584025, 58488.707556461944, 58569.0, 58599.70700146472, 34099.0, 35195.472067919, 35288.0, 61111.24999375039, 62291.0, 14795.63010924714, 14930.402783888523, 14985.550433487013, 14996.550103496913, 14998.0, 11018.50416731249, 11098.55605775776, 11104.333739975627, 11105.888941110647, 11111.444427778579, 19342.132747147625, 19507.101712104588, 19618.215271388985, 19636.509087272647, 19662.0, 7332.853342933218, 7423.294786995227, 7486.962565187139, 7633.465657403928, 7666.233376662289, 810.2424233341726, 850.7235148576614, 876.8465518534231, 929.3912487320815, 940.47333493244, 25920.74079259221, 25981.22056338313, 26905.461890762075, 27193.728062719514, 27229.04698335549, 784.3058892879728, 888.7422647432302, 971.455984648599, 1014.1329163565193, 1017.4048181813574, 13913.0, 14073.3003133731, 14134.131748419868, 14201.573952781433, 14298.714025719635, 386905.0, 387734.0, 389591.0, 392431.0, 393500.0, 50513.0, 51141.48858511367, 51219.74390128026, 51244.74377628088, 51285.23072153921, 1066.5627092891878, 1173.8943495085311, 1204.9096317776027, 1212.1090998116554, 1215.6778453709774, 27392.863035684695, 28811.0, 29080.27299317534, 29429.26426839346, 29615.555766663947, 42441.0, 42589.787051064544, 42818.35772463478, 42929.0, 42988.78505607452, 291199.0, 293860.0, 294330.0, 295121.0, 295510.0, 22614.208502702328, 25795.742042579335, 26367.472650547264, 27195.864020679768, 27435.45129097367, 41627.0, 41913.79043104765, 42335.36496952487, 42972.0, 43457.0, 35603.64396356003, 35980.0, 36789.632103679694, 37004.25991480209, 37095.0, 35666.286674266885, 36011.45982810207, 36400.27199456049, 36403.27193456063, 36548.45177322289, 31909.68090319067, 32117.839410802797, 35866.28267434689, 36375.0, 36426.8178659105, 30784.0, 32071.198220044687, 32623.0, 32771.0, 32859.0, 24801.751982479946, 25066.0, 25211.243662690147, 25657.871710641328, 25672.61491077598], "value": 17669.82322340382, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.84366644176225, 373.3224198080484, 374.5748575366958, 383.42869125003716, 390.42802294638346, 15647.295871685774, 16950.91524542377, 17288.0, 17303.567410814736, 17438.47684569465, 16086.195690215472, 16103.0, 17193.570160745956, 17198.140092995363, 17199.0, 4918.8770280743, 5268.947310526884, 5295.8146464873735, 5308.734563271821, 5309.62832601718, 3732.9440058399146, 3912.1979994101284, 5162.6128040397125, 5774.133879918004, 6119.204503414549, 6170.938290617104, 6186.0, 6204.47261982732, 6210.565260431772, 6219.533534984872, 5948.226730525047, 6109.266887973449, 6136.325004249529, 6140.416660417253, 6222.595531290452, 3402.4726167443837, 5027.49725027498, 5329.813456529042, 5337.0, 5393.541548968343, 19715.309964151187, 20480.795192048037, 20510.79489205104, 20528.281510147222, 20530.0, 1948.4252145617077, 2029.2694629933212, 2104.326615483046, 2114.9636678027655, 2242.5954145426153, 12783.233006019576, 13192.340382980909, 13406.798898016537, 13480.865191348157, 13486.19082855022, 1722.0270547140951, 1725.6289897671936, 1802.387188355952, 1910.2740958435845, 1924.874883132592, 68516.3148368515, 68925.0, 69029.65485172592, 69791.65104174498, 69802.65098674526, 9419.481928493862, 9636.614535418645, 10201.183905287558, 10245.897541024495, 10306.536205870603, 13852.653683657787, 13930.303484825718, 13939.860601394059, 13947.302634868216, 13953.930230348986, 7023.8595228095155, 7059.964700176466, 7202.243764404767, 7220.530665506831, 7475.9252407476315, 6947.409470194989, 7070.292970702889, 7071.92928070723, 7144.749933752398, 7237.203907570163, 3951.4665520154986, 4014.2573623879675, 4017.276890159741, 4120.196561670446, 4471.977640111843, 1664.7835781348347, 1772.503698964292, 1813.432761422447, 1841.5027942455729, 1854.1934258597553, 790.8102055506752, 810.6149578950069, 830.4311546590604, 915.4873270968279, 936.9344145909857, 16004.439844605384, 16530.58673533171, 16668.0, 17087.914560427118, 17207.741883871753, 814.9633266503022, 843.7047033538336, 858.3347905373386, 869.9826003479895, 878.1087196495562, 9367.391119577342, 9427.90572094284, 9475.147236748726, 9653.9034609653, 9879.209663226924, 400681.0, 402025.0, 404402.0, 405742.0, 410495.0, 47910.76044619754, 48575.27137092946, 76665.61667191629, 77855.0, 79111.0, 861.7285555050264, 881.3610132653774, 890.5947793753827, 909.7816524034316, 911.3984770051734, 15075.396984120513, 15178.696426071638, 15236.3905443781, 15268.968757340566, 15537.922310388376, 33793.49309760307, 35654.465183021755, 36776.816115919246, 36980.81509592435, 37349.81325093357, 51262.74368628133, 51302.486975129774, 51537.48462515477, 52655.73672131615, 53788.73105634447, 7603.429742769204, 7623.69505219785, 7681.6543255552515, 7684.923150768421, 7901.012373453318, 10490.265681402228, 11447.942760286145, 11614.361210133524, 11781.882181178422, 11817.468213930566, 9629.085236902483, 9776.364536305118, 9814.607415703578, 9860.950695246478, 9939.204863611038, 9411.717648470556, 9972.401655900669, 10049.0, 10081.193504519475, 10139.949300253451, 9523.428594284365, 9617.519124043909, 9700.369475984038, 9718.271129665161, 10109.545070471699, 7416.666250018654, 7439.330460258603, 7592.924070759222, 7695.4997925134685, 8000.239977202156, 7474.551526908403, 9313.208377288007, 9400.106989836228, 9541.522923853918, 9694.321397502106], "value": 8224.773689620806, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1210.8062709966407, 1378.0216046606906, 1405.45187376923, 1505.4053648808722, 1728.0150314320833, 6490.415862572368, 7736.110347310061, 7956.443048986574, 7957.880631790527, 8217.6302066407, 7925.762227133181, 8082.070561885385, 8087.757367278977, 8088.0, 8092.878606820902, 2255.165588732167, 2278.1229226747737, 2288.4050146961827, 2293.20884294918, 2294.036504668035, 2176.793204645556, 2213.6679498075255, 2266.0822366941334, 2271.4548508357957, 2271.9886400568057, 2096.297740257008, 2100.4433825036376, 2102.180149741602, 2111.292716939827, 2159.3090211132444, 2169.7287839020123, 2173.250228671106, 2175.9564808703817, 2177.2706143441887, 2179.08478439056, 2161.103142195987, 2201.889905504718, 2205.007746514059, 2219.0679914435977, 2222.5443784024237, 7815.452918295721, 8047.557384343859, 8069.6368663410285, 8114.431989760719, 8124.796880077986, 4739.336492890998, 4853.708777473327, 4857.951420485785, 4859.368282123337, 4864.829730959399, 2793.7206279372103, 2859.6139521164587, 2882.394697113609, 2920.109366643173, 2931.0181089334883, 876.9517676527788, 887.2281115429553, 892.906244844295, 894.6287290774321, 907.4509921497465, 11004.944975275152, 11079.944600277027, 11091.112710983101, 11172.217944743872, 11172.497237624246, 4040.6565441937178, 4140.91718165641, 4208.894777630584, 4211.578842115764, 4258.765767882796, 8673.913260867437, 8719.258862996716, 8738.737837864874, 8777.385583009256, 8781.604827782765, 4675.929861052087, 4676.392069031004, 4684.110019096361, 4685.6017238535105, 4730.929036064462, 3584.946225806615, 3782.7730336179916, 3883.922321553553, 4330.437043184429, 4382.649388048949, 3217.742580593547, 3462.6537346265172, 3477.4957631143848, 3495.0563347895927, 3569.4824250483534, 1030.0883717909703, 1068.3376306689902, 1068.5191663751343, 1077.4881931082673, 1085.7448499602588, 711.697528550364, 818.7953011747063, 834.3367023216557, 836.0970152235572, 847.588919374103, 5155.639105262596, 5258.631895767336, 5278.0, 5430.511253987082, 5497.312835895513, 410.5422453963809, 417.31768558407225, 417.81616088920777, 420.8716341515867, 441.1992234095107, 3597.712183025352, 3614.981925090358, 3629.473726309723, 3691.077230692327, 3741.794201318899, 9502.952485237667, 10087.798244035079, 10155.543000564992, 10319.380837149645, 10340.586376544854, 10088.69733907984, 10121.0, 10130.08829205375, 10131.645392411378, 10136.087752102347, 7430.96284518574, 7432.814179645444, 7639.388848892076, 7650.158482566913, 7670.539767613849, 5282.683039017671, 5306.257124002565, 5316.122839731401, 5403.405625381283, 5449.782008719607, 9487.0, 9505.809883802423, 9515.476648784383, 9548.52257387114, 9626.374285671409, 8828.690995815115, 9198.586063627286, 9200.631974720936, 9479.336446448959, 9503.904960950578, 5921.61509501881, 6094.0, 6095.908561371494, 6562.409383155539, 6737.124173857367, 6923.0, 6981.720731170696, 7251.0, 7455.440841936768, 7477.813054673677, 7062.8234294141, 7172.354488096096, 7210.315020073084, 7296.927030729625, 7369.226231245642, 6968.163820341591, 7020.7893763187185, 7153.1416230050645, 7164.068671072727, 7271.454640901848, 6011.098335249748, 6160.168377269011, 6165.691715414301, 6171.753129874754, 6450.0, 4620.907581848412, 4696.524571816899, 4911.68074075184, 4941.085899108676, 4998.275250088789, 4741.83403580873, 4747.548982846624, 4807.326974223542, 4825.541573550507, 5005.274235235797], "value": 4089.6288075708617, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.4195006811616, 303.85415000799617, 307.95226739855326, 310.0543342804446, 315.13338319621045, 4733.384659994204, 4770.928436073457, 4843.903121937568, 4866.85399438017, 4892.14387482191, 4628.62970962323, 4789.677006651771, 4790.5448982346625, 4822.204336284509, 4824.807007719687, 3835.328817456948, 3838.366669499529, 3845.442410850425, 3846.4230365445196, 3884.8834534964, 3648.179159689062, 3694.224212915278, 3850.942235866464, 3864.574896761354, 3867.477890484791, 3773.8490460381554, 3832.482614847002, 3839.6544311012003, 3849.9807500962456, 3851.268259030775, 3798.2783271178528, 3802.0684932191652, 3815.656590906804, 3827.119762454623, 3850.7497012694366, 3403.4554471284723, 3413.634546181547, 3417.128632198798, 3425.383430982422, 3427.1260828488826, 4622.884427889296, 4670.416197975253, 4671.159191345557, 4687.835925742616, 4689.273162659793, 4323.746113627044, 4332.91334173318, 4335.306350983859, 4348.73907565544, 4354.303311470181, 4997.4258108696, 5031.597472202215, 5031.924521132186, 5038.949610503884, 5043.722595257259, 3554.9466757998653, 3702.6667599916136, 3707.5169932027134, 3716.7955762433326, 3728.6271372862766, 5198.194279886586, 5207.166853303491, 5244.921326180111, 5247.658902171346, 5261.947380526184, 3792.4500947362476, 3798.3542797724454, 3806.467094606757, 3808.2383523295453, 3815.542134943769, 3569.6430356964615, 3862.1503269280715, 3863.5943225961432, 3864.768113913174, 3888.4361767544115, 4182.749035057906, 4243.618074373321, 4245.766482843412, 4265.338872474771, 4265.893352666146, 4951.851444456672, 4953.281774142729, 5006.199008158677, 5022.748862556858, 5068.746562671926, 1239.7458521003173, 1265.1207410849556, 1295.8185853980451, 1305.8759417855288, 1311.475409836054, 824.2705205892709, 824.7979245084873, 832.825106727594, 835.2023817254508, 838.4550042472441, 3969.7419667721506, 3987.8205480753436, 3995.9800200998807, 4025.215083058834, 4036.4752582164133, 4687.742174180453, 4696.624270058387, 4714.646401519831, 4715.976420117878, 4730.361401210861, 3957.1689945111275, 3982.601739825994, 3986.8405263789705, 4001.199760048002, 4004.9399259010556, 2362.7991620712087, 2406.57884870147, 2414.6136618141013, 2453.6196889482158, 2462.6429167770575, 4347.5217726050105, 4393.6704747144095, 4395.604395604411, 4399.0, 4439.600435960714, 4766.0, 4782.808687652455, 4783.736894470768, 4807.567318941312, 4808.735519546459, 4195.30777421722, 4351.477822661301, 4410.338449232577, 4471.8434854779925, 4476.462824461086, 4719.032598317405, 4724.763761811827, 4735.550122738335, 4735.763211839326, 4754.881127971828, 4637.513061128668, 4667.74327411982, 4670.64970127235, 4683.718976861399, 4688.859334219979, 4178.979105104455, 4391.714538554984, 4397.372972000252, 4462.799174037111, 4492.865214043584, 3358.4794356874722, 3420.880269190666, 3433.656634336546, 3434.553508043938, 3441.896743097711, 4648.233671204921, 4662.65030122749, 4683.297505374085, 4711.798491384675, 5003.54968052877, 4895.828645997373, 4989.650724449254, 5037.546620804145, 5059.494050594911, 5100.821471248489, 5067.543921047123, 5076.390833100052, 5076.416212135652, 5092.439831618593, 5096.566791822736, 4737.147313483606, 4924.82763103304, 5004.749762511787, 5015.824446144367, 5032.899342013213, 5050.419201791841, 5058.26655134996, 5080.898382032413, 5091.66904151229, 5092.9745351273, 4921.9015619688125, 4944.629152813482, 4972.726500042532, 4985.0, 5026.698398096126], "value": 3697.196812993561, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.9171353580803, 664.0835646807411, 673.4208580620667, 679.7926632377123, 688.6763221285995, 11765.764684706312, 12738.108332416734, 13037.087403881733, 13241.602751917433, 13328.266945318004, 12252.387380630977, 13523.526676566322, 13954.372053257603, 13966.860331396683, 14572.927135364334, 622.1290193728771, 764.4572353628903, 792.2117493094365, 792.4096548071694, 795.1094773853292, 776.1384862802284, 798.2456578533288, 799.2247519905682, 799.5162926429514, 799.7960520067375, 843.9704610338639, 850.37497439382, 850.6682393866397, 850.7150104714897, 851.0553285852699, 642.0561774191931, 808.5876203136384, 821.650798410673, 842.7261140129483, 843.6920524008754, 614.5820841827556, 614.7817524778728, 614.8493619063313, 615.0405367626516, 615.59986009094, 12410.503579856795, 12461.252324860538, 12540.874591254062, 12570.245785252913, 12611.117221794479, 10734.194935379877, 11277.097832173406, 11303.604373846876, 11357.318560886291, 11636.825447618292, 10609.84085238722, 10772.892271077268, 10802.297850639683, 10836.07893329068, 10866.565337386495, 3983.940240896389, 4019.336809426441, 4035.4955630546183, 4039.4950631171105, 4137.97931010346, 53239.733801330745, 55419.722901385234, 55451.72274138644, 57809.132863007086, 63994.68002659957, 9104.635814567344, 9332.44005359667, 9805.313628045968, 10176.694699159038, 10379.325343852626, 17797.644047119244, 17961.281548737905, 17964.820351796578, 17984.0, 18092.36676716335, 7009.824754381181, 7018.508704390643, 7166.856662866713, 7216.3505284524645, 7358.668859901317, 3776.5090538229856, 3872.5740168581433, 3935.0752573145287, 3956.8812935611977, 4072.185562887375, 2907.6656184538624, 3037.39252149571, 3037.8177309361067, 3039.4377040247623, 3040.8935687251283, 504.0825697231078, 513.5224241455408, 523.3118449239314, 524.727141886217, 538.3432212700499, 461.4854437302384, 508.9540993258889, 529.9390570084413, 556.4213218253052, 580.7299605683293, 6812.216595091529, 7151.7854464366155, 7205.171405288354, 7291.9270807292305, 7492.625368731542, 506.62762869291043, 536.6806749983831, 541.5667466027163, 546.8359492152339, 558.8658721906713, 3173.3335999439914, 3312.850921708529, 3408.9602671185526, 3536.3457760314423, 3627.111357717376, 51782.74108629508, 90491.0, 95265.0, 95590.52204738931, 96888.0, 46357.0, 48271.5172848274, 48431.273530897066, 82299.5885020571, 83047.16952830394, 50598.74700626473, 66101.6694916532, 67864.3213567868, 72238.0, 73253.26746732571, 7481.0, 7516.323530882247, 7528.4353673473615, 7602.391808655184, 7685.730999414994, 37902.62097378991, 39177.0, 39193.0, 40244.59755402408, 40255.0, 39950.80024599859, 43104.35343469913, 53225.46774532205, 60302.396976029675, 63582.0, 10230.437325947145, 10448.843267350843, 10496.025358460724, 10734.73163170927, 10915.290506117077, 11885.049196064121, 11898.515294257835, 12266.570670026505, 12349.073819463756, 12383.380830958597, 10504.159667226451, 10707.357558546511, 10776.29954052984, 11047.337159770439, 11081.390523521284, 9607.903920960702, 9957.302988791005, 10069.144122749649, 10287.43419111956, 10332.121769649664, 11228.214025018171, 11409.543618255177, 11414.714632134263, 11492.032356015356, 11792.29246245228, 8752.606132723915, 8808.95595522044, 8809.603567839335, 9087.727368178965, 9214.216791572791, 8868.733937981871, 8898.510581918057, 9159.122379911969, 9182.770430739285, 9199.77000574991], "value": 6226.72767487531, "unit": "score"}], "name": "dromaeo_css", "value": 6342.033820408595, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 113.0, 112.0, 113.0, 112.0, 113.0, 113.0, 112.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 130.0, 135.0, 182.0, 129.0, 170.0, 163.0, 132.0, 198.0, 129.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 163.0, 161.0, 162.0, 161.0, 161.0, 159.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 129.0, 75.0, 76.0, 73.0, 75.0, 97.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 95.0, 111.0, 85.0, 86.0, 86.0, 124.0, 85.0, 86.0, 126.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 94.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 60.0, 63.0, 63.0, 63.0, 61.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 67.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 84.0, 83.0, 85.0, 93.0, 99.0, 124.0, 89.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 130.0, 139.0, 129.0, 129.0, 130.0, 131.0, 129.0, 144.0, 132.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 169.0, 173.0, 171.0, 171.0, 169.0, 172.0, 171.0, 170.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 71.0, 67.0, 67.0, 67.0, 67.0, 71.0, 67.0, 65.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1555.1, "alertThreshold": 2.0}]} 02:59:13 INFO - Return code: 0 02:59:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:59:13 INFO - # TBPL SUCCESS # 02:59:13 INFO - Running post-action listener: _resource_record_post_action 02:59:13 INFO - ##### 02:59:13 INFO - ##### Finished run-tests step (success) 02:59:13 INFO - ##### 02:59:13 INFO - Running post-run listener: _resource_record_post_run 02:59:13 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 535019520; Read time: 0; Write time: 463092 02:59:13 INFO - TinderboxPrint: CPU usage
13.2% 02:59:13 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:59:13 INFO - TinderboxPrint: I/O write bytes / time
535,019,520 / 463,092 02:59:13 INFO - TinderboxPrint: CPU idle
8,320.5 (86.7%) 02:59:13 INFO - TinderboxPrint: CPU user
1,223.5 (12.8%) 02:59:13 INFO - TinderboxPrint: Swap in / out
0 / 0 02:59:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244985856; Read time: 0; Write time: 285712 02:59:13 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 289447936; Read time: 0; Write time: 177364 02:59:14 INFO - Running post-run listener: _upload_blobber_files 02:59:14 INFO - Blob upload gear active. 02:59:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:59:14 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 02:59:14 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'] 02:59:14 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 02:59:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:59:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:59:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:59:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:15 INFO - (blobuploader) - INFO - Done attempting. 02:59:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:59:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:59:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:20 INFO - (blobuploader) - INFO - Done attempting. 02:59:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:59:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:59:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:20 INFO - (blobuploader) - INFO - Done attempting. 02:59:20 INFO - (blobuploader) - INFO - Iteration through files over. 02:59:20 INFO - Return code: 0 02:59:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:59:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:59:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70002c9a705edbe65f9c2df6e2de7088f9b480fa1d95d90b74719aa9c4bc4aa48e00433d6e44b1489b33b972fd9e3fbf833a3588c19bb7216aca8b81b257add3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36fb19d75c0908709c41867da5423c59e581c97995b4870c18380f2df67f43175cff2e2a833956c34f8435c48efd930e7aae039446a6e45025f242ef2df51d1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60bc4efbcc53485f9ef1e9f13a9768552e134b441960cf6e27ab953c7d15ad02b68a29919e59f91e624008e23f826007e63cc03c7e6ab34612e44e885667a674"} 02:59:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:59:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:59:20 INFO - Contents: 02:59:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70002c9a705edbe65f9c2df6e2de7088f9b480fa1d95d90b74719aa9c4bc4aa48e00433d6e44b1489b33b972fd9e3fbf833a3588c19bb7216aca8b81b257add3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36fb19d75c0908709c41867da5423c59e581c97995b4870c18380f2df67f43175cff2e2a833956c34f8435c48efd930e7aae039446a6e45025f242ef2df51d1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60bc4efbcc53485f9ef1e9f13a9768552e134b441960cf6e27ab953c7d15ad02b68a29919e59f91e624008e23f826007e63cc03c7e6ab34612e44e885667a674"} 02:59:20 INFO - Running post-run listener: copy_logs_to_upload_dir 02:59:20 INFO - Copying logs to upload dir... 02:59:20 INFO - mkdir: /builds/slave/test/build/upload/logs 02:59:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.235539 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-13 02:59:20.677060) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 02:59:20.680905) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820 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/70002c9a705edbe65f9c2df6e2de7088f9b480fa1d95d90b74719aa9c4bc4aa48e00433d6e44b1489b33b972fd9e3fbf833a3588c19bb7216aca8b81b257add3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36fb19d75c0908709c41867da5423c59e581c97995b4870c18380f2df67f43175cff2e2a833956c34f8435c48efd930e7aae039446a6e45025f242ef2df51d1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60bc4efbcc53485f9ef1e9f13a9768552e134b441960cf6e27ab953c7d15ad02b68a29919e59f91e624008e23f826007e63cc03c7e6ab34612e44e885667a674"} build_url:https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/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/70002c9a705edbe65f9c2df6e2de7088f9b480fa1d95d90b74719aa9c4bc4aa48e00433d6e44b1489b33b972fd9e3fbf833a3588c19bb7216aca8b81b257add3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/36fb19d75c0908709c41867da5423c59e581c97995b4870c18380f2df67f43175cff2e2a833956c34f8435c48efd930e7aae039446a6e45025f242ef2df51d1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60bc4efbcc53485f9ef1e9f13a9768552e134b441960cf6e27ab953c7d15ad02b68a29919e59f91e624008e23f826007e63cc03c7e6ab34612e44e885667a674"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 02:59:20.705611) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:59:20.705904) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1465810245.194193-416085820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:59:20.791035) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 02:59:20.791565) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 02:59:20.791828) ========= ========= Total master_lag: 0.18 =========