builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1452375203.24 results: success (0) buildid: 20160109120501 builduid: 8888e622a6a046d3b446fcf73e088207 revision: 410a24275bb588bf1ad44a6fabe19f31fe762273 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.244871) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.245237) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.245524) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006381 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.274269) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.274601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.303601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.303877) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004644 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.351964) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.352239) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.352595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.352865) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-09 13:33:24-- 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% 79.2M=0s 2016-01-09 13:33:24 (79.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168331 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.533904) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.534204) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018024 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.583198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:23.583545) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 410a24275bb588bf1ad44a6fabe19f31fe762273 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 410a24275bb588bf1ad44a6fabe19f31fe762273 --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=934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-09 13:33:24,804 truncating revision to first 12 chars 2016-01-09 13:33:24,804 Setting DEBUG logging. 2016-01-09 13:33:24,804 attempt 1/10 2016-01-09 13:33:24,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/410a24275bb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-09 13:33:25,063 unpacking tar archive at: b2g-inbound-410a24275bb5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552037 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:24.148268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:24.148587) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:24.160409) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:24.160675) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 13:33:24.161031) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-09 13:33:24.161320) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-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', 'B2G-Inbound-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:33:25 INFO - MultiFileLogger online at 20160109 13:33:25 in /builds/slave/test 13:33:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 13:33:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:33:25 INFO - {'append_to_log': False, 13:33:25 INFO - 'base_work_dir': '/builds/slave/test', 13:33:25 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 13:33:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:33:25 INFO - 'branch': 'B2G-Inbound-Non-PGO', 13:33:25 INFO - 'buildbot_json_path': 'buildprops.json', 13:33:25 INFO - 'config_files': ('talos/linux_config.py',), 13:33:25 INFO - 'default_actions': ('clobber', 13:33:25 INFO - 'read-buildbot-config', 13:33:25 INFO - 'download-and-extract', 13:33:25 INFO - 'populate-webroot', 13:33:25 INFO - 'create-virtualenv', 13:33:25 INFO - 'install', 13:33:25 INFO - 'run-tests'), 13:33:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:33:25 INFO - 'download_minidump_stackwalk': True, 13:33:25 INFO - 'download_symbols': 'ondemand', 13:33:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:33:25 INFO - 'tooltool.py': '/tools/tooltool.py', 13:33:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:33:25 INFO - '/tools/misc-python/virtualenv.py')}, 13:33:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:33:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:33:25 INFO - 'installer_path': 'installer.exe', 13:33:25 INFO - 'log_level': 'info', 13:33:25 INFO - 'log_name': 'talos', 13:33:25 INFO - 'log_to_console': True, 13:33:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:33:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:33:25 INFO - 'opt_config_files': (), 13:33:25 INFO - 'pip_index': False, 13:33:25 INFO - 'sps_profile': False, 13:33:25 INFO - 'sps_profile_interval': 0, 13:33:25 INFO - 'suite': 'dromaeojs', 13:33:25 INFO - 'system_bits': '32', 13:33:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:33:25 INFO - 'title': 'talos-linux64-ix-057', 13:33:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:33:25 INFO - 'use_talos_json': True, 13:33:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:33:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:33:25 INFO - 'work_dir': 'build'} 13:33:25 INFO - ##### 13:33:25 INFO - ##### Running clobber step. 13:33:25 INFO - ##### 13:33:25 INFO - Running pre-action listener: _resource_record_pre_action 13:33:25 INFO - Running main action method: clobber 13:33:25 INFO - rmtree: /builds/slave/test/build 13:33:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:33:25 INFO - Running post-action listener: _resource_record_post_action 13:33:25 INFO - ##### 13:33:25 INFO - ##### Running read-buildbot-config step. 13:33:25 INFO - ##### 13:33:25 INFO - Running pre-action listener: _resource_record_pre_action 13:33:25 INFO - Running main action method: read_buildbot_config 13:33:25 INFO - Using buildbot properties: 13:33:25 INFO - { 13:33:25 INFO - "project": "", 13:33:25 INFO - "product": "firefox", 13:33:25 INFO - "script_repo_revision": "production", 13:33:25 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 13:33:25 INFO - "repository": "", 13:33:25 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 13:33:25 INFO - "buildid": "20160109120501", 13:33:25 INFO - "pgo_build": "False", 13:33:25 INFO - "basedir": "/builds/slave/test", 13:33:25 INFO - "buildnumber": 330, 13:33:25 INFO - "slavename": "talos-linux64-ix-057", 13:33:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:33:25 INFO - "platform": "ubuntu64_hw", 13:33:25 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 13:33:25 INFO - "branch": "b2g-inbound", 13:33:25 INFO - "repo_path": "integration/b2g-inbound", 13:33:25 INFO - "revision": "410a24275bb588bf1ad44a6fabe19f31fe762273", 13:33:25 INFO - "stage_platform": "linux64", 13:33:25 INFO - "builduid": "8888e622a6a046d3b446fcf73e088207", 13:33:25 INFO - "slavebuilddir": "test" 13:33:25 INFO - } 13:33:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:33:25 INFO - Running post-action listener: _resource_record_post_action 13:33:25 INFO - ##### 13:33:25 INFO - ##### Running download-and-extract step. 13:33:25 INFO - ##### 13:33:25 INFO - Running pre-action listener: _resource_record_pre_action 13:33:25 INFO - Running main action method: download_and_extract 13:33:25 INFO - mkdir: /builds/slave/test/build/tests 13:33:25 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')]} 13:33:25 INFO - https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:33:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/test_packages.json 13:33:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/test_packages.json 13:33:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:33:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:33:26 INFO - Downloaded 1302 bytes. 13:33:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:33:26 INFO - Using the following test package requirements: 13:33:26 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:33:26 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:33:26 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:26 INFO - u'jsshell-linux-x86_64.zip'], 13:33:26 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:33:26 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:33:26 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:33:26 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:33:26 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:33:26 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:33:26 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:33:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:33:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:33:26 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')]} 13:33:26 INFO - https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:33:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:33:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:33:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:33:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:33:28 INFO - Downloaded 22761034 bytes. 13:33:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:33:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:33:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:33:29 INFO - Return code: 0 13:33:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:29 INFO - https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:33:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:33:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:33:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:33:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:33:31 INFO - Downloaded 22761034 bytes. 13:33:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:33:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:33:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:33:32 INFO - Return code: 0 13:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:32 INFO - https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:33:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:33:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:33:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:33:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:33:33 INFO - Downloaded 11132285 bytes. 13:33:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 13:33:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:33:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:33:34 INFO - Return code: 0 13:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:34 INFO - https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:33:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:33:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:33:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:33:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:33:37 INFO - Downloaded 54052420 bytes. 13:33:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:33:37 INFO - mkdir: /builds/slave/test/properties 13:33:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:33:37 INFO - Writing to file /builds/slave/test/properties/build_url 13:33:37 INFO - Contents: 13:33:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:33:37 INFO - Running post-action listener: _resource_record_post_action 13:33:37 INFO - Running post-action listener: set_extra_try_arguments 13:33:37 INFO - ##### 13:33:37 INFO - ##### Running populate-webroot step. 13:33:37 INFO - ##### 13:33:37 INFO - Running pre-action listener: _resource_record_pre_action 13:33:37 INFO - Running main action method: populate_webroot 13:33:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:33:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:33:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:33:37 INFO - '--tppagecycles', 13:33:37 INFO - '7'], 13:33:37 INFO - 'tests': ['tsvgm']}}, 13:33:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:33:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:33:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:33:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:33:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:33:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:33:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:37 INFO - 'talos_options': ['--e10s'], 13:33:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:37 INFO - 'tests': ['damp', 'tps']}, 13:33:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:37 INFO - 'talos_options': ['--e10s'], 13:33:37 INFO - 'tests': ['damp', 'tps']}, 13:33:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:33:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:33:37 INFO - 'other': {'tests': ['a11yr', 13:33:37 INFO - 'ts_paint', 13:33:37 INFO - 'tpaint', 13:33:37 INFO - 'sessionrestore', 13:33:37 INFO - 'sessionrestore_no_auto_restore']}, 13:33:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:33:37 INFO - 'tests': ['a11yr', 13:33:37 INFO - 'ts_paint', 13:33:37 INFO - 'tpaint', 13:33:37 INFO - 'sessionrestore', 13:33:37 INFO - 'sessionrestore_no_auto_restore']}, 13:33:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:33:37 INFO - 'tests': ['a11yr', 13:33:37 INFO - 'ts_paint', 13:33:37 INFO - 'tpaint', 13:33:37 INFO - 'sessionrestore', 13:33:37 INFO - 'sessionrestore_no_auto_restore']}, 13:33:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:33:37 INFO - 'tests': ['a11yr', 13:33:37 INFO - 'ts_paint', 13:33:37 INFO - 'tpaint', 13:33:37 INFO - 'sessionrestore', 13:33:37 INFO - 'sessionrestore_no_auto_restore']}, 13:33:37 INFO - 'other_l64': {'tests': ['a11yr', 13:33:37 INFO - 'ts_paint', 13:33:37 INFO - 'tpaint', 13:33:37 INFO - 'sessionrestore', 13:33:37 INFO - 'sessionrestore_no_auto_restore']}, 13:33:37 INFO - 'other_nol64': {'tests': ['a11yr', 13:33:37 INFO - 'ts_paint', 13:33:37 INFO - 'tpaint', 13:33:37 INFO - 'sessionrestore', 13:33:37 INFO - 'sessionrestore_no_auto_restore']}, 13:33:37 INFO - 'svgr': {'tests': ['tsvgx', 13:33:37 INFO - 'tsvgr_opacity', 13:33:37 INFO - 'tart', 13:33:37 INFO - 'tscrollx', 13:33:37 INFO - 'cart']}, 13:33:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:33:37 INFO - 'tests': ['tsvgx', 13:33:37 INFO - 'tsvgr_opacity', 13:33:37 INFO - 'tart', 13:33:37 INFO - 'tscrollx', 13:33:37 INFO - 'cart']}, 13:33:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:37 INFO - 'tests': ['tp5o']}, 13:33:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:37 INFO - 'talos_options': ['--e10s'], 13:33:37 INFO - 'tests': ['tp5o']}, 13:33:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:37 INFO - 'talos_options': ['--xperf_path', 13:33:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:37 INFO - 'tests': ['tp5n']}, 13:33:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:37 INFO - 'talos_options': ['--e10s', 13:33:37 INFO - '--xperf_path', 13:33:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:37 INFO - 'tests': ['tp5n']}}, 13:33:37 INFO - 'talos.zip': {'path': '', 13:33:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:33:37 INFO - Running post-action listener: _resource_record_post_action 13:33:37 INFO - ##### 13:33:37 INFO - ##### Running create-virtualenv step. 13:33:37 INFO - ##### 13:33:37 INFO - Running pre-action listener: _resource_record_pre_action 13:33:37 INFO - Running main action method: create_virtualenv 13:33:37 INFO - Creating virtualenv /builds/slave/test/build/venv 13:33:37 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 13:33:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:33:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:33:37 INFO - Using real prefix '/usr' 13:33:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:33:37 INFO - Installing distribute.............................................................................................................................................................................................done. 13:33:39 INFO - Installing pip.................done. 13:33:39 INFO - Return code: 0 13:33:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:33:39 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')]} 13:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:39 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')]} 13:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f45adfbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a3d0>, '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 0x2675ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', '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 13:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:33:39 INFO - Using env: {'DISPLAY': ':0', 13:33:39 INFO - 'HOME': '/home/cltbld', 13:33:39 INFO - 'LANG': 'en_US.UTF-8', 13:33:39 INFO - 'LANGUAGE': 'en_US:en', 13:33:39 INFO - 'LOGNAME': 'cltbld', 13:33:39 INFO - 'MAIL': '/var/mail/cltbld', 13:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:39 INFO - 'MOZ_NO_REMOTE': '1', 13:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:39 INFO - 'NO_EM_RESTART': '1', 13:33:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:39 INFO - 'PWD': '/builds/slave/test', 13:33:39 INFO - 'SHELL': '/bin/bash', 13:33:39 INFO - 'SHLVL': '1', 13:33:39 INFO - 'TERM': 'linux', 13:33:39 INFO - 'TMOUT': '86400', 13:33:39 INFO - 'USER': 'cltbld', 13:33:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', 13:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:39 INFO - '_': '/tools/buildbot/bin/python'} 13:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:39 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 13:33:39 INFO - Cleaning up... 13:33:39 INFO - Return code: 0 13:33:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:33:39 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')]} 13:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:39 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')]} 13:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45adfbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a3d0>, '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 0x2675ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', '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 13:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 13:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 13:33:39 INFO - Using env: {'DISPLAY': ':0', 13:33:39 INFO - 'HOME': '/home/cltbld', 13:33:39 INFO - 'LANG': 'en_US.UTF-8', 13:33:39 INFO - 'LANGUAGE': 'en_US:en', 13:33:39 INFO - 'LOGNAME': 'cltbld', 13:33:39 INFO - 'MAIL': '/var/mail/cltbld', 13:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:39 INFO - 'MOZ_NO_REMOTE': '1', 13:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:39 INFO - 'NO_EM_RESTART': '1', 13:33:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:39 INFO - 'PWD': '/builds/slave/test', 13:33:39 INFO - 'SHELL': '/bin/bash', 13:33:39 INFO - 'SHLVL': '1', 13:33:39 INFO - 'TERM': 'linux', 13:33:39 INFO - 'TMOUT': '86400', 13:33:39 INFO - 'USER': 'cltbld', 13:33:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', 13:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:39 INFO - '_': '/tools/buildbot/bin/python'} 13:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:40 INFO - Downloading/unpacking psutil>=0.7.1 13:33:40 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 13:33:40 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 13:33:40 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 13:33:40 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 13:33:40 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 13:33:40 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 13:33:41 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:33:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:33:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:41 INFO - Installing collected packages: psutil 13:33:41 INFO - Running setup.py install for psutil 13:33:42 INFO - building 'psutil._psutil_linux' extension 13:33:42 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 13:33:42 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 13:33:42 INFO - building 'psutil._psutil_posix' extension 13:33:42 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 13:33:42 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 13:33:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:42 INFO - Successfully installed psutil 13:33:42 INFO - Cleaning up... 13:33:42 INFO - Return code: 0 13:33:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45adfbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a3d0>, '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 0x2675ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', '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 13:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 13:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 13:33:42 INFO - Using env: {'DISPLAY': ':0', 13:33:42 INFO - 'HOME': '/home/cltbld', 13:33:42 INFO - 'LANG': 'en_US.UTF-8', 13:33:42 INFO - 'LANGUAGE': 'en_US:en', 13:33:42 INFO - 'LOGNAME': 'cltbld', 13:33:42 INFO - 'MAIL': '/var/mail/cltbld', 13:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:42 INFO - 'MOZ_NO_REMOTE': '1', 13:33:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:42 INFO - 'NO_EM_RESTART': '1', 13:33:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:42 INFO - 'PWD': '/builds/slave/test', 13:33:42 INFO - 'SHELL': '/bin/bash', 13:33:42 INFO - 'SHLVL': '1', 13:33:42 INFO - 'TERM': 'linux', 13:33:42 INFO - 'TMOUT': '86400', 13:33:42 INFO - 'USER': 'cltbld', 13:33:42 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', 13:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:42 INFO - '_': '/tools/buildbot/bin/python'} 13:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:33:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:33:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:33:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:33:44 INFO - Installing collected packages: mozsystemmonitor 13:33:44 INFO - Running setup.py install for mozsystemmonitor 13:33:44 INFO - Successfully installed mozsystemmonitor 13:33:44 INFO - Cleaning up... 13:33:44 INFO - Return code: 0 13:33:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f45adfbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a3d0>, '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 0x2675ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', '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 13:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:33:44 INFO - Using env: {'DISPLAY': ':0', 13:33:44 INFO - 'HOME': '/home/cltbld', 13:33:44 INFO - 'LANG': 'en_US.UTF-8', 13:33:44 INFO - 'LANGUAGE': 'en_US:en', 13:33:44 INFO - 'LOGNAME': 'cltbld', 13:33:44 INFO - 'MAIL': '/var/mail/cltbld', 13:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:44 INFO - 'MOZ_NO_REMOTE': '1', 13:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:44 INFO - 'NO_EM_RESTART': '1', 13:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:44 INFO - 'PWD': '/builds/slave/test', 13:33:44 INFO - 'SHELL': '/bin/bash', 13:33:44 INFO - 'SHLVL': '1', 13:33:44 INFO - 'TERM': 'linux', 13:33:44 INFO - 'TMOUT': '86400', 13:33:44 INFO - 'USER': 'cltbld', 13:33:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', 13:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:44 INFO - '_': '/tools/buildbot/bin/python'} 13:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:44 INFO - Downloading/unpacking blobuploader==1.2.4 13:33:44 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 13:33:44 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 13:33:44 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 13:33:44 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 13:33:44 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 13:33:44 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 13:33:46 INFO - Downloading blobuploader-1.2.4.tar.gz 13:33:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:33:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:33:46 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 13:33:46 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 13:33:46 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 13:33:46 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 13:33:46 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 13:33:46 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 13:33:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:33:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:47 INFO - Downloading docopt-0.6.1.tar.gz 13:33:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:33:47 INFO - Installing collected packages: blobuploader, requests, docopt 13:33:47 INFO - Running setup.py install for blobuploader 13:33:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:33:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:33:47 INFO - Running setup.py install for requests 13:33:47 INFO - Running setup.py install for docopt 13:33:47 INFO - Successfully installed blobuploader requests docopt 13:33:47 INFO - Cleaning up... 13:33:47 INFO - Return code: 0 13:33:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f45adfbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a3d0>, '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 0x2675ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', '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 13:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 13:33:47 INFO - Using env: {'DISPLAY': ':0', 13:33:47 INFO - 'HOME': '/home/cltbld', 13:33:47 INFO - 'LANG': 'en_US.UTF-8', 13:33:47 INFO - 'LANGUAGE': 'en_US:en', 13:33:47 INFO - 'LOGNAME': 'cltbld', 13:33:47 INFO - 'MAIL': '/var/mail/cltbld', 13:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:47 INFO - 'MOZ_NO_REMOTE': '1', 13:33:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:47 INFO - 'NO_EM_RESTART': '1', 13:33:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:47 INFO - 'PWD': '/builds/slave/test', 13:33:47 INFO - 'SHELL': '/bin/bash', 13:33:47 INFO - 'SHLVL': '1', 13:33:47 INFO - 'TERM': 'linux', 13:33:47 INFO - 'TMOUT': '86400', 13:33:47 INFO - 'USER': 'cltbld', 13:33:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', 13:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:47 INFO - '_': '/tools/buildbot/bin/python'} 13:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:33:48 INFO - Running setup.py (path:/tmp/pip-yY4iZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:33:48 INFO - Running setup.py (path:/tmp/pip-bBU666-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:33:48 INFO - Running setup.py (path:/tmp/pip-GgfHW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:33:48 INFO - Running setup.py (path:/tmp/pip-OIJeNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:33:48 INFO - Running setup.py (path:/tmp/pip-7qDybk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:33:48 INFO - Running setup.py (path:/tmp/pip-_mnIxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:33:48 INFO - Running setup.py (path:/tmp/pip-HTxzLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:33:48 INFO - Running setup.py (path:/tmp/pip-ASn4LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:33:48 INFO - Running setup.py (path:/tmp/pip-ael_1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:33:48 INFO - Running setup.py (path:/tmp/pip-smUN_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:33:48 INFO - Running setup.py (path:/tmp/pip-kEr4zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:33:48 INFO - Running setup.py (path:/tmp/pip-l__DeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:33:48 INFO - Running setup.py (path:/tmp/pip-mUBgPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:33:49 INFO - Running setup.py (path:/tmp/pip-_6iNA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:49 INFO - Running setup.py (path:/tmp/pip-E7qx1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:33:49 INFO - Running setup.py (path:/tmp/pip-QAvIDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:33:49 INFO - Running setup.py (path:/tmp/pip-vqdXn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:33:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:33:49 INFO - Running setup.py install for manifestparser 13:33:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:33:49 INFO - Running setup.py install for mozcrash 13:33:49 INFO - Running setup.py install for mozdebug 13:33:49 INFO - Running setup.py install for mozdevice 13:33:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:33:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:33:49 INFO - Running setup.py install for mozfile 13:33:49 INFO - Running setup.py install for mozhttpd 13:33:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:33:49 INFO - Running setup.py install for mozinfo 13:33:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:33:50 INFO - Running setup.py install for mozInstall 13:33:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:33:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:33:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:33:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:33:50 INFO - Running setup.py install for mozleak 13:33:50 INFO - Running setup.py install for mozlog 13:33:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:33:50 INFO - Running setup.py install for moznetwork 13:33:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:33:50 INFO - Running setup.py install for mozprocess 13:33:50 INFO - Running setup.py install for mozprofile 13:33:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:33:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:33:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:33:50 INFO - Running setup.py install for mozrunner 13:33:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:33:50 INFO - Running setup.py install for mozscreenshot 13:33:50 INFO - Running setup.py install for moztest 13:33:50 INFO - Running setup.py install for mozversion 13:33:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:33:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:33:51 INFO - Cleaning up... 13:33:51 INFO - Return code: 0 13:33:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33:51 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')]} 13:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:51 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')]} 13:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f45adfbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a3d0>, '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 0x2675ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', '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 13:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:33:51 INFO - Using env: {'DISPLAY': ':0', 13:33:51 INFO - 'HOME': '/home/cltbld', 13:33:51 INFO - 'LANG': 'en_US.UTF-8', 13:33:51 INFO - 'LANGUAGE': 'en_US:en', 13:33:51 INFO - 'LOGNAME': 'cltbld', 13:33:51 INFO - 'MAIL': '/var/mail/cltbld', 13:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:51 INFO - 'MOZ_NO_REMOTE': '1', 13:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:51 INFO - 'NO_EM_RESTART': '1', 13:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:51 INFO - 'PWD': '/builds/slave/test', 13:33:51 INFO - 'SHELL': '/bin/bash', 13:33:51 INFO - 'SHLVL': '1', 13:33:51 INFO - 'TERM': 'linux', 13:33:51 INFO - 'TMOUT': '86400', 13:33:51 INFO - 'USER': 'cltbld', 13:33:51 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', 13:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:51 INFO - '_': '/tools/buildbot/bin/python'} 13:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:33:51 INFO - Running setup.py (path:/tmp/pip-WfsFkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:33:51 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)) 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:33:51 INFO - Running setup.py (path:/tmp/pip-skgfNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:33:51 INFO - Running setup.py (path:/tmp/pip-aL1P_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:33:51 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)) 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:33:51 INFO - Running setup.py (path:/tmp/pip-4pdAJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:33:51 INFO - Running setup.py (path:/tmp/pip-wK1y5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:33:51 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)) 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:33:51 INFO - Running setup.py (path:/tmp/pip-i7Ir0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:33:51 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)) 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:33:51 INFO - Running setup.py (path:/tmp/pip-KGXpEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:33:51 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)) 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:33:51 INFO - Running setup.py (path:/tmp/pip-P9Srcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:33:51 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)) 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:33:51 INFO - Running setup.py (path:/tmp/pip-Bra5kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:33:51 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)) 13:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:33:51 INFO - Running setup.py (path:/tmp/pip-8_DVt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:33:52 INFO - Running setup.py (path:/tmp/pip-ziqiot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:33:52 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)) 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:33:52 INFO - Running setup.py (path:/tmp/pip-b78r7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:33:52 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)) 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:33:52 INFO - Running setup.py (path:/tmp/pip-gvd8CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:33:52 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)) 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:33:52 INFO - Running setup.py (path:/tmp/pip-itFH5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:33:52 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)) 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:52 INFO - Running setup.py (path:/tmp/pip-xGkkb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:52 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)) 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:33:52 INFO - Running setup.py (path:/tmp/pip-G4rE1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:33:52 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)) 13:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:33:52 INFO - Running setup.py (path:/tmp/pip-iKMcdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:33:52 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)) 13:33:52 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:33:52 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:33:52 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)) 13:33:52 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:33:52 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:33:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33:54 INFO - Downloading blessings-1.5.1.tar.gz 13:33:54 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:33:54 INFO - Installing collected packages: blessings 13:33:54 INFO - Running setup.py install for blessings 13:33:54 INFO - Successfully installed blessings 13:33:54 INFO - Cleaning up... 13:33:54 INFO - Return code: 0 13:33:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:33:54 INFO - Reading from file tmpfile_stdout 13:33:54 INFO - Current package versions: 13:33:54 INFO - argparse == 1.2.1 13:33:54 INFO - blessings == 1.5.1 13:33:54 INFO - blobuploader == 1.2.4 13:33:54 INFO - docopt == 0.6.1 13:33:54 INFO - manifestparser == 1.1 13:33:54 INFO - mozInstall == 1.12 13:33:54 INFO - mozcrash == 0.16 13:33:54 INFO - mozdebug == 0.1 13:33:54 INFO - mozdevice == 0.47 13:33:54 INFO - mozfile == 1.2 13:33:54 INFO - mozhttpd == 0.7 13:33:54 INFO - mozinfo == 0.9 13:33:54 INFO - mozleak == 0.1 13:33:54 INFO - mozlog == 3.1 13:33:54 INFO - moznetwork == 0.27 13:33:54 INFO - mozprocess == 0.22 13:33:54 INFO - mozprofile == 0.28 13:33:54 INFO - mozrunner == 6.11 13:33:54 INFO - mozscreenshot == 0.1 13:33:54 INFO - mozsystemmonitor == 0.0 13:33:54 INFO - moztest == 0.7 13:33:54 INFO - mozversion == 1.4 13:33:54 INFO - psutil == 3.1.1 13:33:54 INFO - requests == 1.2.3 13:33:54 INFO - wsgiref == 0.1.2 13:33:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f45adfbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a3d0>, '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 0x2675ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', '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 13:33:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:33:54 INFO - Using env: {'DISPLAY': ':0', 13:33:54 INFO - 'HOME': '/home/cltbld', 13:33:54 INFO - 'LANG': 'en_US.UTF-8', 13:33:54 INFO - 'LANGUAGE': 'en_US:en', 13:33:54 INFO - 'LOGNAME': 'cltbld', 13:33:54 INFO - 'MAIL': '/var/mail/cltbld', 13:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:54 INFO - 'MOZ_NO_REMOTE': '1', 13:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:54 INFO - 'NO_EM_RESTART': '1', 13:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:54 INFO - 'PWD': '/builds/slave/test', 13:33:54 INFO - 'SHELL': '/bin/bash', 13:33:54 INFO - 'SHLVL': '1', 13:33:54 INFO - 'TERM': 'linux', 13:33:54 INFO - 'TMOUT': '86400', 13:33:54 INFO - 'USER': 'cltbld', 13:33:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', 13:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:54 INFO - '_': '/tools/buildbot/bin/python'} 13:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:54 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)) 13:33:54 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)) 13:33:54 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)) 13:33:54 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)) 13:33:54 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)) 13:33:54 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)) 13:33:54 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)) 13:33:54 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)) 13:33:54 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)) 13:33:54 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)) 13:33:54 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)) 13:33:54 INFO - Cleaning up... 13:33:55 INFO - Return code: 0 13:33:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:33:55 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')]} 13:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:55 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')]} 13:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f45adfbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a3d0>, '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 0x2675ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', '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 13:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:33:55 INFO - Using env: {'DISPLAY': ':0', 13:33:55 INFO - 'HOME': '/home/cltbld', 13:33:55 INFO - 'LANG': 'en_US.UTF-8', 13:33:55 INFO - 'LANGUAGE': 'en_US:en', 13:33:55 INFO - 'LOGNAME': 'cltbld', 13:33:55 INFO - 'MAIL': '/var/mail/cltbld', 13:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:55 INFO - 'MOZ_NO_REMOTE': '1', 13:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:55 INFO - 'NO_EM_RESTART': '1', 13:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:55 INFO - 'PWD': '/builds/slave/test', 13:33:55 INFO - 'SHELL': '/bin/bash', 13:33:55 INFO - 'SHLVL': '1', 13:33:55 INFO - 'TERM': 'linux', 13:33:55 INFO - 'TMOUT': '86400', 13:33:55 INFO - 'USER': 'cltbld', 13:33:55 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', 13:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:55 INFO - '_': '/tools/buildbot/bin/python'} 13:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:55 INFO - Downloading/unpacking jsonschema 13:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:33:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:33:56 INFO - Downloading/unpacking functools32 (from jsonschema) 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33:57 INFO - Downloading functools32-3.2.3-2.tar.gz 13:33:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:33:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:33:57 INFO - warning: no files found matching '*.txt' 13:33:57 INFO - no previously-included directories found matching 'build' 13:33:57 INFO - no previously-included directories found matching 'dist' 13:33:57 INFO - no previously-included directories found matching '.git*' 13:33:57 INFO - Installing collected packages: jsonschema, functools32 13:33:57 INFO - Running setup.py install for functools32 13:33:57 INFO - warning: no files found matching '*.txt' 13:33:57 INFO - no previously-included directories found matching 'build' 13:33:57 INFO - no previously-included directories found matching 'dist' 13:33:57 INFO - no previously-included directories found matching '.git*' 13:33:57 INFO - Successfully installed jsonschema functools32 13:33:57 INFO - Cleaning up... 13:33:57 INFO - Return code: 0 13:33:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f45adfbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a3d0>, '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 0x2675ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676360>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', '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 13:33:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 13:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 13:33:57 INFO - Using env: {'DISPLAY': ':0', 13:33:57 INFO - 'HOME': '/home/cltbld', 13:33:57 INFO - 'LANG': 'en_US.UTF-8', 13:33:57 INFO - 'LANGUAGE': 'en_US:en', 13:33:57 INFO - 'LOGNAME': 'cltbld', 13:33:57 INFO - 'MAIL': '/var/mail/cltbld', 13:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:57 INFO - 'MOZ_NO_REMOTE': '1', 13:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:57 INFO - 'NO_EM_RESTART': '1', 13:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:57 INFO - 'PWD': '/builds/slave/test', 13:33:57 INFO - 'SHELL': '/bin/bash', 13:33:57 INFO - 'SHLVL': '1', 13:33:57 INFO - 'TERM': 'linux', 13:33:57 INFO - 'TMOUT': '86400', 13:33:57 INFO - 'USER': 'cltbld', 13:33:57 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', 13:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:57 INFO - '_': '/tools/buildbot/bin/python'} 13:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:57 INFO - Downloading/unpacking flake8 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:33:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:33:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:33:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:33:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:33:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33: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 13:33:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:33:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:33:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:33:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:33:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:33:59 INFO - no previously-included directories found matching 'docs/_build' 13:34:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:34:00 INFO - Running setup.py install for pep8 13:34:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:34:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:34:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:34:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:34:00 INFO - no previously-included directories found matching 'docs/_build' 13:34:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:34:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:34:00 INFO - Cleaning up... 13:34:00 INFO - Return code: 0 13:34:00 INFO - Running post-action listener: _resource_record_post_action 13:34:00 INFO - Running post-action listener: _start_resource_monitoring 13:34:00 INFO - Starting resource monitoring. 13:34:00 INFO - ##### 13:34:00 INFO - ##### Running install step. 13:34:00 INFO - ##### 13:34:00 INFO - Running pre-action listener: _resource_record_pre_action 13:34:00 INFO - Running main action method: install 13:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:34:00 INFO - Reading from file tmpfile_stdout 13:34:00 INFO - Detecting whether we're running mozinstall >=1.0... 13:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:34:00 INFO - Reading from file tmpfile_stdout 13:34:00 INFO - Output received: 13:34:00 INFO - Usage: mozinstall [options] installer 13:34:00 INFO - Options: 13:34:00 INFO - -h, --help show this help message and exit 13:34:00 INFO - -d DEST, --destination=DEST 13:34:00 INFO - Directory to install application into. [default: 13:34:00 INFO - "/builds/slave/test"] 13:34:00 INFO - --app=APP Application being installed. [default: firefox] 13:34:00 INFO - mkdir: /builds/slave/test/build/application 13:34:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:34:16 INFO - Reading from file tmpfile_stdout 13:34:16 INFO - Output received: 13:34:16 INFO - /builds/slave/test/build/application/firefox/firefox 13:34:16 INFO - Running post-action listener: _resource_record_post_action 13:34:16 INFO - ##### 13:34:16 INFO - ##### Running run-tests step. 13:34:16 INFO - ##### 13:34:16 INFO - Running pre-action listener: _resource_record_pre_action 13:34:16 INFO - Running main action method: run_tests 13:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:34:16 INFO - Python 2.7.3 13:34:16 INFO - Return code: 0 13:34:16 INFO - grabbing minidump binary from tooltool 13:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:34:16 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a3d0>, '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 0x2675ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:34:16 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 13:34:16 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 13:34:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:34:16 INFO - Return code: 0 13:34:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:34:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:34:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:34:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:34:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:34:17 INFO - Return code: 0 13:34:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 13:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 13:34:17 INFO - Using env: {'DISPLAY': ':0', 13:34:17 INFO - 'HOME': '/home/cltbld', 13:34:17 INFO - 'LANG': 'en_US.UTF-8', 13:34:17 INFO - 'LANGUAGE': 'en_US:en', 13:34:17 INFO - 'LOGNAME': 'cltbld', 13:34:17 INFO - 'MAIL': '/var/mail/cltbld', 13:34:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:34:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:17 INFO - 'MOZ_NO_REMOTE': '1', 13:34:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:17 INFO - 'NO_EM_RESTART': '1', 13:34:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:17 INFO - 'PWD': '/builds/slave/test', 13:34:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:34:17 INFO - 'SHELL': '/bin/bash', 13:34:17 INFO - 'SHLVL': '1', 13:34:17 INFO - 'TERM': 'linux', 13:34:17 INFO - 'TMOUT': '86400', 13:34:17 INFO - 'USER': 'cltbld', 13:34:17 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225', 13:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:17 INFO - '_': '/tools/buildbot/bin/python'} 13:34:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 13:34:17 INFO - mozversion application_buildid: 20160109120501 13:34:17 INFO - mozversion application_changeset: 410a24275bb588bf1ad44a6fabe19f31fe762273 13:34:17 INFO - mozversion application_display_name: Nightly 13:34:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:34:17 INFO - mozversion application_name: Firefox 13:34:17 INFO - mozversion application_remotingname: firefox 13:34:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 13:34:17 INFO - mozversion application_vendor: Mozilla 13:34:17 INFO - mozversion application_version: 46.0a1 13:34:17 INFO - mozversion platform_buildid: 20160109120501 13:34:17 INFO - mozversion platform_changeset: 410a24275bb588bf1ad44a6fabe19f31fe762273 13:34:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 13:34:17 INFO - mozversion platform_version: 46.0a1 13:34:17 INFO - using testdate: 1452375257 13:34:17 INFO - actual date: 1452375257 13:34:17 INFO - starting webserver on 'localhost:34959' 13:34:17 INFO - SUITE-START | Running 3 tests 13:34:17 INFO - TEST-START | dromaeo_css 13:34:17 INFO - operating with platform_type : linux_ 13:34:17 INFO - Initialising browser for dromaeo_css test... 13:34:17 INFO - TEST-INFO | started process 12609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFlUXp3/profile http://localhost:34959/getInfo.html) 13:34:22 INFO - PROCESS | 12609 | __metrics Screen width/height:1600/1200 13:34:22 INFO - PROCESS | 12609 | colorDepth:24 13:34:22 INFO - PROCESS | 12609 | Browser inner width/height: 1024/697 13:34:22 INFO - PROCESS | 12609 | __metrics 13:34:22 INFO - PROCESS | 12609 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:34:22 INFO - PROCESS | 12609 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:34:23 INFO - TEST-INFO | 12609: exit 0 13:34:23 INFO - Browser initialized. 13:34:23 INFO - Running cycle 1/1 for dromaeo_css test... 13:34:23 INFO - TEST-INFO | started process 12704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFlUXp3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:34:35 INFO - PROCESS | 12704 | RSS: Main: 149278720 13:34:35 INFO - PROCESS | 12704 | 13:35:26 INFO - PROCESS | 12704 | 1452375326529 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] 13:37:38 INFO - PROCESS | 12704 | Cycle 1(1): loaded http://localhost:34959/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34959/tests/dromaeo/cssquery-ext.html) 13:37:39 INFO - PROCESS | 12704 | RSS: Main: 237117440 13:37:39 INFO - PROCESS | 12704 | 13:40:41 INFO - PROCESS | 12704 | Cycle 1(1): loaded http://localhost:34959/tests/dromaeo/cssquery-ext.html (next: http://localhost:34959/tests/dromaeo/cssquery-jquery.html) 13:40:42 INFO - PROCESS | 12704 | RSS: Main: 229167104 13:40:42 INFO - PROCESS | 12704 | 13:43:44 INFO - PROCESS | 12704 | Cycle 1(1): loaded http://localhost:34959/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34959/tests/dromaeo/cssquery-mootools.html) 13:43:45 INFO - PROCESS | 12704 | RSS: Main: 232247296 13:43:45 INFO - PROCESS | 12704 | 13:46:47 INFO - PROCESS | 12704 | Cycle 1(1): loaded http://localhost:34959/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34959/tests/dromaeo/cssquery-prototype.html) 13:46:47 INFO - PROCESS | 12704 | RSS: Main: 212668416 13:46:47 INFO - PROCESS | 12704 | 13:49:50 INFO - PROCESS | 12704 | Cycle 1(1): loaded http://localhost:34959/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34959/tests/dromaeo/cssquery-yui.html) 13:49:51 INFO - PROCESS | 12704 | RSS: Main: 217206784 13:49:51 INFO - PROCESS | 12704 | 13:52:53 INFO - PROCESS | 12704 | Cycle 1(1): loaded http://localhost:34959/tests/dromaeo/cssquery-yui.html (next: http://localhost:34959/tests/dromaeo/cssquery-dojo.html) 13:52:54 INFO - PROCESS | 12704 | RSS: Main: 288714752 13:52:54 INFO - PROCESS | 12704 | 13:52:54 INFO - PROCESS | 12704 | __start_tp_report 13:52:54 INFO - PROCESS | 12704 | _x_x_mozilla_page_load 13:52:54 INFO - PROCESS | 12704 | _x_x_mozilla_page_load_details 13:52:54 INFO - PROCESS | 12704 | |i|pagename|runs| 13:52:54 INFO - PROCESS | 12704 | |0;dojo.html;2577.368544706547;2665.40028493589;2675.077098401051;2687.543117669996;2699.865006749663;4294.441722576061;4463.352813841991;4468.240399132147;4479.395281636982;4480.887977800557;4445.48876879159;4482.417285752847;4495.572920572548;4519.435070616173;4620.584147426731;3953.98023009886;4054.4729185205883;4138.586141385852;4172.645325147366;4303.311470164775;3992.4011398290345;4245.15601471893;4260;4278.465191851019;4289.978550107245;4106.384042393635;4109.753414795122;4117.279476091687;4194.30793919003;4217.683673724483;4143.461350024508;4150.045489537393;4156.896077598054;4159.958400415987;4191.580841915784;4132.566080561528;4142.150859073882;4157.08544120293;4165.812538435747;4180.519240287375;4254.106637606106;4370.6940514164025;4377.080813029268;4389.692721509496;4502;4776.761161941924;4815.277708343741;4836.516348365135;4836.564709176191;4883.389576302962;4841.443234028062;4843.2250839865455;4859.125357435661;4863.902721945577;4902.019596080798;4365.738055716667;4373.737575745466;4452.265376212888;4472.530384309665;4481.619062379669;4988.850334489971;4988.850334489971;4992.326035985168;5008.248762685626;5017.322661440732;4770.689905156154;4776.928346074812;4783.569478746929;4823.589994850477;4834.20235661119;4621.052684199731;4744.027474367816;4744.833930812405;4853.757312134379;4869.172240719086;4683.414573178353;4757.09615173116;4759.333693282943;4767.237242041326;4791.664583479123;4734.644901632391;4769.165396055676;4769.189237829577;4772.284157376422;4822.132016237041;3879.709021823318;3974.8410063597134;3976.4631774710624;4038.7778672172726;4074.7758873262255;3533.7703049301713;3578.1949061461482;3621.9094522637147;3624.0577449863226;3638.490611314418;4126.319157339006;4127.236461254677;4140.275451795924;4160.854370097032;4188.120494696087;4607.746573938399;4750.239961606127;4785.210440277385;4785.976070119627;4844.636652251025;4030.133521292936;4048.352263637804;4140.068484591003;4222.683298752544;4240.342746874239;4260.467441569804;4293.355996600472;4296.291111966553;4328.069465065026;4338.978305108454;4499.460064792246;4609.847538115471;4611.354410382549;4612.884677883079;4656.022235330618;4700.106979673988;4724.811007559797;4731.219348807408;4832.637552183671;4833.879153021062;4567.566081222279;4591.701539399928;4593.839215627437;4596.816127355002;4631.050634619962;4712.434507859079;4724.645651576215;4731.550502702238;4736.786844591933;4764.666473346832;4639.744814035125;4764.213904705684;4776.641751868554;4786.7845946931775;4790.233562629963;4709.270063140219;4717.2216584263215;4718.433787945469;4722.150012997693;4759.6430267729365;4684.672072954861;4689.835855745169;4696.365990591226;4711.505291944297;4747.264174053027;4436.82252709888;4539.228331183641;4541.114482675846;4620.075984802986;4627.8611641650805;4655.30170474418;4737.644676649334;4770.594499467584;4783.354247176726;4786.904261914812;4566.041131362451;4568.840090596813;4572.177008138567;4573.474050484237;4608.562186592402 13:52:54 INFO - PROCESS | 12704 | |1;ext.html;477.3746392226184;495.5861855350782;505.5854199556364;507.08471209466944;512.1344927073246;24776.87611561942;25202;33118.66881331186;33167;33285.833570832176;36539.634603653954;36856.63143368565;37029.62970370296;37228.81385593075;37250;6757.121574195372;6870.1068861048;7532.397408207344;7710.151883292833;7712.113106992683;9520.190783783386;9646.180074693659;9726.610935562569;9737.415755054684;9739.123478886899;9171.678991235309;9250.907490925072;9262.444253344787;9268.675596354129;9271.443713377184;6880.8967865482055;7066.293370662944;7069.222385537587;7082.575045497287;9270.397424167408;6807.3873351398615;9492.762680932963;9716.562754676057;9731.318807683465;9738.659146929824;32838.34323313544;33219.33561328784;33251;33311.16722081943;33325.16687082818;2776.3891943772337;2858.399736055431;2965.6144701188923;3115.2523394385184;3461.117415059169;24358.14746483882;24585.631215531783;24668.87665561661;24861.87569062143;24984.625230621554;3339.8497067632015;3447.5345828313107;3503.7021853142514;3536.840842162109;3544.043108360754;214481;216301;216467;216540;217017;55509;55952.44047559554;56157.71921140368;56185.15722264169;56201.43798562044;58449.70775146182;58636.706816465645;58785.706071470224;58981.705091474265;59065;13824.723505529833;14171.433142674177;14338.426462941365;14414.279286035657;14557;11437.771244575062;11561.479733412016;11565.074794016627;11565.363904985306;11582.36297003673;18707;18878.811211887707;18901.81098189028;18943;18976;7326.413886889036;7584.696612135564;7595.088589369311;7626.313631773167;7724.7682569523;807.4025221336169;809.7489778168787;890.4612709310903;914.5427286356821;940.8965013848472;23069.07723691067;23145;23285;23291.88354058219;23309.650355244685;897.2463130970017;944.1313991128178;944.593824655391;944.8535477001076;1004.7387679203459;11855.288682679067;12238.877611223774;12502.124851260507;12573;12667.239965602093;318766;321682;322391;323554;324073;47483;47731.76134119307;47748.28377574339;47866.52133478621;47877.76061119672;1159.878212787662;1166.8891455311732;1173.9706507337385;1175.2067354535654;1193.9283642981623;25523.489530209663;26302.736972630028;26623.600645990715;26827.597586035834;26840.194794156207;42223.57776422196;42923.35614965716;42925;43008;43039.354409683256;247214;247339;247575;247984;248124;34409.311813764085;34748.65251347454;35264;37874.242515150094;38455;34616;34784.65215347814;34802.303953921284;34906.47640285347;35728.10679733028;32401;32474.35051299008;32968;33310.66689333173;34035.319293613495;26162.476750465266;34420.31159376748;35850.46224306586;38625.42061869131;39068.804655976535;32942;33105.172370690925;33115.66884331126;33282.667173328926;33460.1634959128;29044.12867613975;29127.12618621445;29510.704892950795;29574.852125740093;29691.85154074216;22858.885705571367;23127.76872231256;23174.652380214648;23251.18620848262;23402.76597234074 13:52:54 INFO - PROCESS | 12704 | |2;jquery.html;321.95492631031647;336.34748587739784;338.7544030577831;340.6287147009759;342.91084318077293;11998;12438.378081095954;14435.278236088194;14813.259337033145;15091.547253582396;8376.706815261467;9687.467189304585;9979.900200997989;12975.74048519029;15210.467633632825;4372.519022907478;4576.83981060663;4577.793999270041;4578.244589642705;4583.014651849851;3286.7699261051735;3409.181796368866;3410.880619178329;3412.385770561298;4320.56794320567;3406.3017081498356;3407.4207384744655;4901;5082.720450375228;5083.949160508403;5049.2678561608545;5114.590832733391;5709.143628455702;5712;5712.257406537124;4824.879378015543;5057.165567681328;5073.0107629012355;5074.086664400406;5075.619328550373;11468.598599049077;11599.6520104397;11602.361870097142;11617.88382116185;13479;1663.1767275198854;1703.403808666969;1746.3974928649595;1768.2838450427598;1831.9267229310813;8435.95782021086;8538.316934645276;8845.601947912359;10590.523426445752;12617.179883307555;1759.876808623397;1769.3630293094475;1785.431198478125;1799.8560115190753;1821.836034756865;49440.50559494395;49774.75112624414;50561;51023.234651480256;51319.48680513222;9638.373505722106;9694.418334899929;9720.416774993522;9738.36700614472;9779.168770654574;12329.075319351085;12329.198602090835;12333.198342107735;12334.383280835922;12336.938315308545;6704;6721.899171512431;6812.557183783138;6830.31696830313;6961.756338528127;6522.608643481406;6543.083968244449;6824.21521525021;6875.449964002868;6889.621070841152;4059.6752259819737;4133.607307305801;4149.566803465577;4181.059261666101;4194.035371864488;1646.2345009570606;1683.452877814715;1685.1405783050486;1704.6675898199733;1777.1380880273057;746.608030783832;800.6557180412478;803.8593246181895;852.2117041736369;877.3288434347729;14587.416503339748;14706.926465367605;15138.016028958082;15378.538643840702;15423.305951232222;762.7139822566537;822.8642274024719;825.6862392291011;838.1283465196128;883.1212943121635;8029.437939344307;8264.132266112092;8382.742588611634;8399.538025408661;8570.614322355508;304352;309783.4510827431;309881;310204;423262;60373.396266036776;64853;66950.63543010264;67344.66327668428;69955.73496937362;1041.250299784154;1060.061845266929;1060.6287799270194;1070.7323169207698;1082.7888561730388;13684.399964006807;13813.171209727449;14128.50550230737;14219.217943013233;14296.356663949939;30289.848550757106;31050.378992420476;31266.687333127287;31383.529247061768;31415.21461963469;40393.79803101083;40432.79783601063;40444.1911161781;40641.18717625572;41452.79273603613;6347.143135676624;6439.388258115471;6487.18910136233;6549.4760419167305;6652.7006284716335;7844.372450203856;9733.707988760349;9751.80496390054;9890.258230632875;9953.651622193189;8203.466774659628;8238.258556729923;8249.958750206211;8264.21489958453;8398.580070996548;8786.516741579275;8927.062658421031;8972.19250267479;9089.954550227207;9143.817123657622;6074.218361789662;7092.503524753424;8020.438569300093;8226.712065077932;8626.18051285127;6456.192975878015;6737.292584278776;6757.054012438361;6778.627175505198;6876.828079298058;6780.559263647847;8071.4753541019645;8087.676492940452;8116.107228204774;8178.918210818054 13:52:54 INFO - PROCESS | 12704 | |3;mootools.html;1196.1626861197165;1404.6277736399852;1412.6892083741577;1556.7898333724943;1761.4363403710818;6084.391560843919;6938.444924406048;7117.110361204849;7122.180949190844;7126.3942564882045;7173.605451700168;7363.41092712583;7368.373688236493;7370.815729606763;7374.225706300828;2143.9892800536013;2166.068590506082;2168.30614203455;2169.1215057901577;2169.6853956176346;2069.6998935154393;2110.8522403431766;2165.0257384177185;2165.9241926532573;2183.9890800545977;2115.6086124067097;2118.0680500579774;2129.361191642509;2129.7870212978733;2180.1279488204764;2151.4728891421546;2159.6112699714045;2160.7191065161587;2161.1787520742096;2167.804897559219;2111.7465904091455;2159.967600485994;2167.0248388225364;2168.111074459464;2169.013099039949;7577.5453472791805;7625.466217364787;7625.961870190614;7637.809054773675;7643.541387516767;4193.077522944947;4263.59495847894;4268.701190916637;4292.656587472995;4303.053328267776;2857.39994601134;2889.754370878478;2989.7458716009164;2993.476141675198;3013.8794448222043;845.7674139611595;852.6845067325067;876.3646356391629;888.2006194425069;890.3366991591306;10506.474676266233;10511.579536818517;10511.947440262826;10519.421431821247;10524.631637892637;4018.3168861293652;4028.6374226319185;4093.1813637272667;4124.90689967159;4126.711130220856;9014.86477702835;9017.098290171061;9020.639174433081;9023.278137748965;9023.323250756219;4362.825486980485;4372.890677733082;4374.300111982131;4375.321825117112;4377.9781101094295;3269.0519749272444;3373.224158443572;3856.2865869814173;3950.20995800841;3953.4267531207815;3477.2871561329866;3507.7719948203285;3524.665156810099;3535.292941411728;3559.039059453985;1063.6862125672944;1092.5192915117323;1093.3002878157986;1101.895319944604;1104.817705078653;1185.8280549320473;1206.2460961898814;1208.456194712383;1221.9144659873723;1225.8345123408226;7066.646667666596;7074.398676112485;7205.207427183006;7217.206107328189;7233.529820561646;1000.9299349045497;1016.6289304403839;1028.9742756430999;1033.8397548380012;1034.1881622925966;5531.502164805106;5532.30846144232;5537.833864984057;5602.159676048625;5603.131514615241;8837.60230789616;8948.060453652402;9218.63125474987;9281.489518076436;9295.76760580991;9211.723648290563;9493.572789224501;9494.810103798023;9497.477638729937;9506.572204250826;6989.650517474106;7025.262347453546;7213.963930180315;7345.853082938312;7346.595937223504;6899.965500172668;6940.7917762467205;6978.79063628092;6987.475939304674;6990.440764738911;8215.09633940278;8325.875111873447;8415.368847336353;8438.367122465717;8547.615357308812;7846.960765196138;8011.719589814562;8016.559089250147;8106.797330066795;8126.715564955434;5349.144136938071;5481.725913704219;5483.067878460751;6396.232452105591;6544.411003009752;5580.386157522588;5652.2086907833755;6757.898631520433;6898.379145876896;6924.826879328057;6231.781887633911;6583.506237032146;6634.137562116894;6651.833704157241;6668.633225172662;6410.5192110592825;6414.5189110815945;6472.449841763503;6580.76967306142;6654.170103221652;6626.933730662631;6687.76592819249;6690.431313338226;6692.297308782702;6698.196216454056;6123.7550497981365;6166.229221347332;6178.289496707756;6195.845103872439;6219.440250377488;6057.394260574084;6107.6640784757265;6115.908261375994;6122.785702500391;6244.594101383395 13:52:54 INFO - PROCESS | 12704 | |4;prototype.html;302.61416693715523;309.60370725471404;314.529777981917;318.7672998710941;326.7843223472508;5201.349831271091;5284.841454756353;5326.6537675051095;5343.946560534394;5346.9732651336735;5222.164453687411;5249.317588713471;5253.816116435925;5257;5266.552343050836;3883.650471457568;3978.3037968355566;4090.0797320602924;4099.405586190001;4101.097758493134;4035.2131334389805;4162.209180255742;4164.146349998258;4164.604362585549;4185.644220241283;4133.607307305801;4134.958650413502;4138.234426631083;4139.958600414003;4146.6268035876765;3849.711271654623;4001.419794129835;4039.6768258539246;4127.133302006582;4141.81361838718;3672.3940549809518;3676.1361080146144;3680.2823449427374;3688.704903607705;3690.6309369063147;5120.027194833007;5128.820491282787;5129.9743501282255;5135.537801597837;5149.639525233235;4778.307145463888;4789.066132104241;4793.664443488957;4796.664233503656;4802.06359759847;5441.646292990982;5564.777408903679;5578.135389014709;5584.357798853143;5586.776528938837;4012.0772222388723;4013.13717550728;4015.819288132012;4017.959820401788;4020.718549701522;5836.737346819404;5841.824745257649;5845.649261044351;5849.005669036274;5849.941500584982;4146.274401979702;4153.314703074019;4154.646855017297;4155.4182414462;4156.480439945007;4112.670986321087;4213.220554197484;4231.048014196781;4237.915241695149;4243.893902652459;4766.118268120409;4767.070421267819;4769.070031343855;4780.880477988078;4780.880477988078;5570.777168913279;5580.302462192226;5581.469760372839;5581.665100094007;5586.1062230043;1462.90491118077;1500.8123984501938;1502.6318551954841;1502.9098254104788;1504.1050574907913;1032.5353590884133;1037.190991027;1039.4854546999134;1048.4705223861902;1065.5524679634573;4853.174960256765;4868.391451068616;4868.707877527359;4870.951290487121;4874.658773885794;5756.3380211276235;5761.942380576224;5767.596268261182;5770.163326317745;5772.3938986406665;4855.198892182751;4863.683860549053;4864.78108485119;4871.926921096187;4876.21980483121;2876.266552029219;2942.8969986050383;3048.8932887348838;3079.5226739855357;3111.8910838120555;5456.6725996439545;5550.056490396642;5555.0834112371;5555.444455554493;5569.582281328917;5992.370801065826;5993.910091348634;6009.969950150309;6011.398860113954;6011.458968692838;5554.416786237468;5557.916631250615;5559.082751345983;5561.694106824163;5568.693721845338;5623.268975033219;5800.680962546931;5819.883602328015;5838;5861.443162899518;5678.346990096192;5699.2590963174525;5733.426657334233;5737.340205876378;5748.712564371681;5538.224648549126;5545.750441230235;5546.195801608825;5550.47270509301;5551.028570000314;4027.7583344999393;4138.172365526846;4185.058361868555;4186.644135248538;4189.748615083105;5697.800576979952;5774.393688662798;5775.942240577709;5780.450857168562;5780.479756821906;5556.138798486241;5558.194061861089;5558.666480011212;5559.8888022240135;5562.638428502134;5497.092979658471;5572.85756419941;5574.665520068809;5585.916211256916;5586.301712285965;5360.624756267024;5453.64551304164;5466.562674985912;5468.644538105011;5475.863103422446;5586.944130558805;5589.888202236014;5592.02139625572;5596.160575913483;5603.439656034364;5280;5313.521783039545;5405.567554595702;5437.075697131576;5437.3747019091725 13:52:54 INFO - PROCESS | 12704 | |5;yui.html;560.6439910656732;616.3528295289944;636.9681515924202;689.5965859971916;725.1407082607109;10786.67639970801;10913.672589822298;10923.235373523856;10953.83569246462;10967.232293739442;10516.522552463211;10539.789204215911;10646.78706425871;10658.733531661712;10660.520276587553;609.9817005489842;616.3312805605923;751.5753599216439;756.1380026769488;767.4589414462819;766.2988365645427;771.4407054885191;773.1456740301969;773.215186585616;773.3967505345811;629.7134803664321;795.0300633227482;803.9276465118138;805.5770720371822;806.4193780478047;633.3856159525253;634.0236036503778;636.0078277886489;636.8789929913302;769.9538027718298;578.4967078641566;579.5016285994042;580.4949693766408;583.270911360799;584.4097461563808;10660.307080039773;10705.785884282348;10721.83917241242;10722.839157412645;10726.839097413545;10907.872964771872;11272.43637818114;11412.20114591979;11426.428678566039;11477.311361318347;8866.113388661146;9154.771130721718;9253.398529095588;9297.535123243812;9417.105374989365;3170.1599076244815;3214.758893083028;3229.418704633165;3236.3689080629288;3253.398121347558;37330.253394932224;37728.24543509142;38570;38706.225875482334;38731.60928446803;9209.723708288628;9219.90780092204;9226.446413215228;9292.16370526656;9301.53492325381;16049.518514444586;16089.839101608834;16114.677706445806;16134.112623805804;16146.434874779561;6044.455998960027;6193.256809182837;6415.390537898892;6570.474362051024;6578.76974305897;3456.9308613827584;3565.2512972276113;3568.3398571264397;3619.059044648358;3619.2580520993133;2594;2616.175904590048;2629.7501737334924;2632.9078482253412;2641.696204936457;448.24694513218105;462.5628780802177;467.7427414921779;473.6211031175046;474.2577865640262;419.43585876995394;466.7829459301373;513.383939272874;579.6348300570697;585.1602949767098;6835.7949261522235;6856.314368563204;7056.964715176391;7127.2160062393095;7134.072570565793;453.1955778493135;455.80856040463084;571.8055861007277;594.5273507561499;623.329920335641;3249.3988612106837;3359.5128706337446;3380.5267262583257;3409.8636054558037;3449.827508624609;44528;45360.77319613381;45783.313250301275;46053.77623566318;46192;40266.194676106315;40756;40846.79576602098;41109.58890411058;41114.79442602768;37490;38040.42939355912;38083.619163808005;38333.808330958724;38466;7457.142428620561;7556.848863022598;7567.545947243183;7576.962115189609;7721.5753133575945;29481.410371792874;29541.55687664644;29827.552586711652;31004.534931975588;31062.22344441317;36829.26341473209;37420.81289593535;37454.6254537462;37670;37713.62286377101;9205.355625106446;9661.547042769675;9883.30816842814;9987.450690212108;10069.69790906274;11064.557417703201;11077.169212308949;11098;11100.167487438313;11281.32312061279;9529.237660986966;9981;10000.699979000641;10065.993400659876;10213.438260895722;9655.08276713711;9728.124468797841;10074.748131296776;10489.055984961391;10638.202134839763;7734.922650773646;9894.703158905244;9919.801603967735;10249.282550221413;10297.3821570706;8033.6786528538205;8053.516788992679;8068.596570171585;8461.40770146084;8548.786280343042;8129.75610731679;8193.795155120932;8472.44929079608;8521.91478085236;8716.651333946826 13:52:54 INFO - PROCESS | 12704 | __end_tp_report 13:52:54 INFO - PROCESS | 12704 | __start_cc_report 13:52:54 INFO - PROCESS | 12704 | _x_x_mozilla_cycle_collect,1059 13:52:54 INFO - PROCESS | 12704 | __end_cc_report 13:52:54 INFO - PROCESS | 12704 | __startTimestamp1452376374100__endTimestamp 13:52:54 INFO - PROCESS | 12704 | 13:52:54 INFO - PROCESS | 12704 | ------- Summary: start ------- 13:52:54 INFO - PROCESS | 12704 | Number of tests: 6 13:52:54 INFO - PROCESS | 12704 | 13:52:54 INFO - PROCESS | 12704 | [#0] dojo.html Cycles:165 Average:4445.05 Median:4573.47 stddev:447.70 (9.8%) stddev-sans-first:424.42 13:52:54 INFO - PROCESS | 12704 | Values: 2577.4 2665.4 2675.1 2687.5 2699.9 4294.4 4463.4 4468.2 4479.4 4480.9 4445.5 4482.4 4495.6 4519.4 4620.6 3954.0 4054.5 4138.6 4172.6 4303.3 3992.4 4245.2 4260.0 4278.5 4290.0 4106.4 4109.8 4117.3 4194.3 4217.7 4143.5 4150.0 4156.9 4160.0 4191.6 4132.6 4142.2 4157.1 4165.8 4180.5 4254.1 4370.7 4377.1 4389.7 4502.0 4776.8 4815.3 4836.5 4836.6 4883.4 4841.4 4843.2 4859.1 4863.9 4902.0 4365.7 4373.7 4452.3 4472.5 4481.6 4988.9 4988.9 4992.3 5008.2 5017.3 4770.7 4776.9 4783.6 4823.6 4834.2 4621.1 4744.0 4744.8 4853.8 4869.2 4683.4 4757.1 4759.3 4767.2 4791.7 4734.6 4769.2 4769.2 4772.3 4822.1 3879.7 3974.8 3976.5 4038.8 4074.8 3533.8 3578.2 3621.9 3624.1 3638.5 4126.3 4127.2 4140.3 4160.9 4188.1 4607.7 4750.2 4785.2 4786.0 4844.6 4030.1 4048.4 4140.1 4222.7 4240.3 4260.5 4293.4 4296.3 4328.1 4339.0 4499.5 4609.8 4611.4 4612.9 4656.0 4700.1 4724.8 4731.2 4832.6 4833.9 4567.6 4591.7 4593.8 4596.8 4631.1 4712.4 4724.6 4731.6 4736.8 4764.7 4639.7 4764.2 4776.6 4786.8 4790.2 4709.3 4717.2 4718.4 4722.2 4759.6 4684.7 4689.8 4696.4 4711.5 4747.3 4436.8 4539.2 4541.1 4620.1 4627.9 4655.3 4737.6 4770.6 4783.4 4786.9 4566.0 4568.8 4572.2 4573.5 4608.6 13:52:54 INFO - PROCESS | 12704 | 13:52:54 INFO - PROCESS | 12704 | [#1] ext.html Cycles:180 Average:41883.77 Median:33747.74 stddev:69564.61 (206.1%) stddev-sans-first:69690.29 13:52:54 INFO - PROCESS | 12704 | Values: 477.4 495.6 505.6 507.1 512.1 24776.9 25202.0 33118.7 33167.0 33285.8 36539.6 36856.6 37029.6 37228.8 37250.0 6757.1 6870.1 7532.4 7710.2 7712.1 9520.2 9646.2 9726.6 9737.4 9739.1 9171.7 9250.9 9262.4 9268.7 9271.4 6880.9 7066.3 7069.2 7082.6 9270.4 6807.4 9492.8 9716.6 9731.3 9738.7 32838.3 33219.3 33251.0 33311.2 33325.2 2776.4 2858.4 2965.6 3115.3 3461.1 24358.1 24585.6 24668.9 24861.9 24984.6 3339.8 3447.5 3503.7 3536.8 3544.0 214481.0 216301.0 216467.0 216540.0 217017.0 55509.0 55952.4 56157.7 56185.2 56201.4 58449.7 58636.7 58785.7 58981.7 59065.0 13824.7 14171.4 14338.4 14414.3 14557.0 11437.8 11561.5 11565.1 11565.4 11582.4 18707.0 18878.8 18901.8 18943.0 18976.0 7326.4 7584.7 7595.1 7626.3 7724.8 807.4 809.7 890.5 914.5 940.9 23069.1 23145.0 23285.0 23291.9 23309.7 897.2 944.1 944.6 944.9 1004.7 11855.3 12238.9 12502.1 12573.0 12667.2 318766.0 321682.0 322391.0 323554.0 324073.0 47483.0 47731.8 47748.3 47866.5 47877.8 1159.9 1166.9 1174.0 1175.2 1193.9 25523.5 26302.7 26623.6 26827.6 26840.2 42223.6 42923.4 42925.0 43008.0 43039.4 247214.0 247339.0 247575.0 247984.0 248124.0 34409.3 34748.7 35264.0 37874.2 38455.0 34616.0 34784.7 34802.3 34906.5 35728.1 32401.0 32474.4 32968.0 33310.7 34035.3 26162.5 34420.3 35850.5 38625.4 39068.8 32942.0 33105.2 33115.7 33282.7 33460.2 29044.1 29127.1 29510.7 29574.9 29691.9 22858.9 23127.8 23174.7 23251.2 23402.8 13:52:54 INFO - PROCESS | 12704 | 13:52:54 INFO - PROCESS | 12704 | [#2] jquery.html Cycles:180 Average:20279.34 Median:27805.13 stddev:55100.64 (198.2%) stddev-sans-first:55234.83 13:52:54 INFO - PROCESS | 12704 | Values: 322.0 336.3 338.8 340.6 342.9 11998.0 12438.4 14435.3 14813.3 15091.5 8376.7 9687.5 9979.9 12975.7 15210.5 4372.5 4576.8 4577.8 4578.2 4583.0 3286.8 3409.2 3410.9 3412.4 4320.6 3406.3 3407.4 4901.0 5082.7 5083.9 5049.3 5114.6 5709.1 5712.0 5712.3 4824.9 5057.2 5073.0 5074.1 5075.6 11468.6 11599.7 11602.4 11617.9 13479.0 1663.2 1703.4 1746.4 1768.3 1831.9 8436.0 8538.3 8845.6 10590.5 12617.2 1759.9 1769.4 1785.4 1799.9 1821.8 49440.5 49774.8 50561.0 51023.2 51319.5 9638.4 9694.4 9720.4 9738.4 9779.2 12329.1 12329.2 12333.2 12334.4 12336.9 6704.0 6721.9 6812.6 6830.3 6961.8 6522.6 6543.1 6824.2 6875.4 6889.6 4059.7 4133.6 4149.6 4181.1 4194.0 1646.2 1683.5 1685.1 1704.7 1777.1 746.6 800.7 803.9 852.2 877.3 14587.4 14706.9 15138.0 15378.5 15423.3 762.7 822.9 825.7 838.1 883.1 8029.4 8264.1 8382.7 8399.5 8570.6 304352.0 309783.5 309881.0 310204.0 423262.0 60373.4 64853.0 66950.6 67344.7 69955.7 1041.3 1060.1 1060.6 1070.7 1082.8 13684.4 13813.2 14128.5 14219.2 14296.4 30289.8 31050.4 31266.7 31383.5 31415.2 40393.8 40432.8 40444.2 40641.2 41452.8 6347.1 6439.4 6487.2 6549.5 6652.7 7844.4 9733.7 9751.8 9890.3 9953.7 8203.5 8238.3 8250.0 8264.2 8398.6 8786.5 8927.1 8972.2 9090.0 9143.8 6074.2 7092.5 8020.4 8226.7 8626.2 6456.2 6737.3 6757.1 6778.6 6876.8 6780.6 8071.5 8087.7 8116.1 8178.9 13:52:54 INFO - PROCESS | 12704 | 13:52:54 INFO - PROCESS | 12704 | [#3] mootools.html Cycles:180 Average:5187.07 Median:6070.89 stddev:2753.15 (45.4%) stddev-sans-first:2744.53 13:52:54 INFO - PROCESS | 12704 | Values: 1196.2 1404.6 1412.7 1556.8 1761.4 6084.4 6938.4 7117.1 7122.2 7126.4 7173.6 7363.4 7368.4 7370.8 7374.2 2144.0 2166.1 2168.3 2169.1 2169.7 2069.7 2110.9 2165.0 2165.9 2184.0 2115.6 2118.1 2129.4 2129.8 2180.1 2151.5 2159.6 2160.7 2161.2 2167.8 2111.7 2160.0 2167.0 2168.1 2169.0 7577.5 7625.5 7626.0 7637.8 7643.5 4193.1 4263.6 4268.7 4292.7 4303.1 2857.4 2889.8 2989.7 2993.5 3013.9 845.8 852.7 876.4 888.2 890.3 10506.5 10511.6 10511.9 10519.4 10524.6 4018.3 4028.6 4093.2 4124.9 4126.7 9014.9 9017.1 9020.6 9023.3 9023.3 4362.8 4372.9 4374.3 4375.3 4378.0 3269.1 3373.2 3856.3 3950.2 3953.4 3477.3 3507.8 3524.7 3535.3 3559.0 1063.7 1092.5 1093.3 1101.9 1104.8 1185.8 1206.2 1208.5 1221.9 1225.8 7066.6 7074.4 7205.2 7217.2 7233.5 1000.9 1016.6 1029.0 1033.8 1034.2 5531.5 5532.3 5537.8 5602.2 5603.1 8837.6 8948.1 9218.6 9281.5 9295.8 9211.7 9493.6 9494.8 9497.5 9506.6 6989.7 7025.3 7214.0 7345.9 7346.6 6900.0 6940.8 6978.8 6987.5 6990.4 8215.1 8325.9 8415.4 8438.4 8547.6 7847.0 8011.7 8016.6 8106.8 8126.7 5349.1 5481.7 5483.1 6396.2 6544.4 5580.4 5652.2 6757.9 6898.4 6924.8 6231.8 6583.5 6634.1 6651.8 6668.6 6410.5 6414.5 6472.4 6580.8 6654.2 6626.9 6687.8 6690.4 6692.3 6698.2 6123.8 6166.2 6178.3 6195.8 6219.4 6057.4 6107.7 6115.9 6122.8 6244.6 13:52:54 INFO - PROCESS | 12704 | 13:52:54 INFO - PROCESS | 12704 | [#4] prototype.html Cycles:180 Average:4655.28 Median:5211.76 stddev:1346.92 (25.8%) stddev-sans-first:1310.48 13:52:54 INFO - PROCESS | 12704 | Values: 302.6 309.6 314.5 318.8 326.8 5201.3 5284.8 5326.7 5343.9 5347.0 5222.2 5249.3 5253.8 5257.0 5266.6 3883.7 3978.3 4090.1 4099.4 4101.1 4035.2 4162.2 4164.1 4164.6 4185.6 4133.6 4135.0 4138.2 4140.0 4146.6 3849.7 4001.4 4039.7 4127.1 4141.8 3672.4 3676.1 3680.3 3688.7 3690.6 5120.0 5128.8 5130.0 5135.5 5149.6 4778.3 4789.1 4793.7 4796.7 4802.1 5441.6 5564.8 5578.1 5584.4 5586.8 4012.1 4013.1 4015.8 4018.0 4020.7 5836.7 5841.8 5845.6 5849.0 5849.9 4146.3 4153.3 4154.6 4155.4 4156.5 4112.7 4213.2 4231.0 4237.9 4243.9 4766.1 4767.1 4769.1 4780.9 4780.9 5570.8 5580.3 5581.5 5581.7 5586.1 1462.9 1500.8 1502.6 1502.9 1504.1 1032.5 1037.2 1039.5 1048.5 1065.6 4853.2 4868.4 4868.7 4871.0 4874.7 5756.3 5761.9 5767.6 5770.2 5772.4 4855.2 4863.7 4864.8 4871.9 4876.2 2876.3 2942.9 3048.9 3079.5 3111.9 5456.7 5550.1 5555.1 5555.4 5569.6 5992.4 5993.9 6010.0 6011.4 6011.5 5554.4 5557.9 5559.1 5561.7 5568.7 5623.3 5800.7 5819.9 5838.0 5861.4 5678.3 5699.3 5733.4 5737.3 5748.7 5538.2 5545.8 5546.2 5550.5 5551.0 4027.8 4138.2 4185.1 4186.6 4189.7 5697.8 5774.4 5775.9 5780.5 5780.5 5556.1 5558.2 5558.7 5559.9 5562.6 5497.1 5572.9 5574.7 5585.9 5586.3 5360.6 5453.6 5466.6 5468.6 5475.9 5586.9 5589.9 5592.0 5596.2 5603.4 5280.0 5313.5 5405.6 5437.1 5437.4 13:52:54 INFO - PROCESS | 12704 | 13:52:54 INFO - PROCESS | 12704 | [#5] yui.html Cycles:180 Average:11526.64 Median:45918.54 stddev:12872.81 (28.0%) stddev-sans-first:12882.58 13:52:54 INFO - PROCESS | 12704 | Values: 560.6 616.4 637.0 689.6 725.1 10786.7 10913.7 10923.2 10953.8 10967.2 10516.5 10539.8 10646.8 10658.7 10660.5 610.0 616.3 751.6 756.1 767.5 766.3 771.4 773.1 773.2 773.4 629.7 795.0 803.9 805.6 806.4 633.4 634.0 636.0 636.9 770.0 578.5 579.5 580.5 583.3 584.4 10660.3 10705.8 10721.8 10722.8 10726.8 10907.9 11272.4 11412.2 11426.4 11477.3 8866.1 9154.8 9253.4 9297.5 9417.1 3170.2 3214.8 3229.4 3236.4 3253.4 37330.3 37728.2 38570.0 38706.2 38731.6 9209.7 9219.9 9226.4 9292.2 9301.5 16049.5 16089.8 16114.7 16134.1 16146.4 6044.5 6193.3 6415.4 6570.5 6578.8 3456.9 3565.3 3568.3 3619.1 3619.3 2594.0 2616.2 2629.8 2632.9 2641.7 448.2 462.6 467.7 473.6 474.3 419.4 466.8 513.4 579.6 585.2 6835.8 6856.3 7057.0 7127.2 7134.1 453.2 455.8 571.8 594.5 623.3 3249.4 3359.5 3380.5 3409.9 3449.8 44528.0 45360.8 45783.3 46053.8 46192.0 40266.2 40756.0 40846.8 41109.6 41114.8 37490.0 38040.4 38083.6 38333.8 38466.0 7457.1 7556.8 7567.5 7577.0 7721.6 29481.4 29541.6 29827.6 31004.5 31062.2 36829.3 37420.8 37454.6 37670.0 37713.6 9205.4 9661.5 9883.3 9987.5 10069.7 11064.6 11077.2 11098.0 11100.2 11281.3 9529.2 9981.0 10000.7 10066.0 10213.4 9655.1 9728.1 10074.7 10489.1 10638.2 7734.9 9894.7 9919.8 10249.3 10297.4 8033.7 8053.5 8068.6 8461.4 8548.8 8129.8 8193.8 8472.4 8521.9 8716.7 13:52:54 INFO - PROCESS | 12704 | -------- Summary: end -------- 13:52:54 INFO - PROCESS | 12704 | 13:52:54 INFO - TEST-INFO | 12704: exit 0 13:52:54 INFO - TEST-OK | dromaeo_css | took 1117368ms 13:52:54 INFO - TEST-START | kraken 13:52:54 INFO - operating with platform_type : linux_ 13:52:54 INFO - Initialising browser for kraken test... 13:52:54 INFO - TEST-INFO | started process 12891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJdxCJ/profile http://localhost:34959/getInfo.html) 13:52:59 INFO - PROCESS | 12891 | __metrics Screen width/height:1600/1200 13:52:59 INFO - PROCESS | 12891 | colorDepth:24 13:52:59 INFO - PROCESS | 12891 | Browser inner width/height: 1024/697 13:52:59 INFO - PROCESS | 12891 | __metrics 13:52:59 INFO - PROCESS | 12891 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:52:59 INFO - PROCESS | 12891 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:53:00 INFO - TEST-INFO | 12891: exit 0 13:53:00 INFO - Browser initialized. 13:53:00 INFO - Running cycle 1/1 for kraken test... 13:53:00 INFO - TEST-INFO | started process 12972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJdxCJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:12 INFO - PROCESS | 12972 | RSS: Main: 148987904 13:53:12 INFO - PROCESS | 12972 | 13:53:14 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34959/tests/kraken/driver.html?testName=audio-beat-detection) 13:53:15 INFO - PROCESS | 12972 | RSS: Main: 187645952 13:53:15 INFO - PROCESS | 12972 | 13:53:18 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34959/tests/kraken/driver.html?testName=audio-dft) 13:53:18 INFO - PROCESS | 12972 | RSS: Main: 177242112 13:53:18 INFO - PROCESS | 12972 | 13:53:21 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34959/tests/kraken/driver.html?testName=audio-fft) 13:53:22 INFO - PROCESS | 12972 | RSS: Main: 162025472 13:53:22 INFO - PROCESS | 12972 | 13:53:24 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34959/tests/kraken/driver.html?testName=audio-oscillator) 13:53:25 INFO - PROCESS | 12972 | RSS: Main: 163381248 13:53:25 INFO - PROCESS | 12972 | 13:53:27 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34959/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:53:27 INFO - PROCESS | 12972 | RSS: Main: 165736448 13:53:27 INFO - PROCESS | 12972 | 13:53:30 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34959/tests/kraken/driver.html?testName=imaging-darkroom) 13:53:31 INFO - PROCESS | 12972 | RSS: Main: 165236736 13:53:31 INFO - PROCESS | 12972 | 13:53:34 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34959/tests/kraken/driver.html?testName=imaging-desaturate) 13:53:35 INFO - PROCESS | 12972 | RSS: Main: 165675008 13:53:35 INFO - PROCESS | 12972 | 13:53:38 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34959/tests/kraken/driver.html?testName=json-parse-financial) 13:53:38 INFO - PROCESS | 12972 | RSS: Main: 164954112 13:53:38 INFO - PROCESS | 12972 | 13:53:40 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34959/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:53:41 INFO - PROCESS | 12972 | RSS: Main: 177623040 13:53:41 INFO - PROCESS | 12972 | 13:53:43 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34959/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:53:43 INFO - PROCESS | 12972 | RSS: Main: 175362048 13:53:43 INFO - PROCESS | 12972 | 13:53:45 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34959/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:53:46 INFO - PROCESS | 12972 | RSS: Main: 182636544 13:53:46 INFO - PROCESS | 12972 | 13:53:48 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:53:49 INFO - PROCESS | 12972 | RSS: Main: 191967232 13:53:49 INFO - PROCESS | 12972 | 13:53:52 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:53:52 INFO - PROCESS | 12972 | RSS: Main: 187777024 13:53:52 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:34959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34959/tests/kraken/driver.html?testName=ai-astar) 13:53:54 INFO - PROCESS | 12972 | RSS: Main: 246095872 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | __start_tp_report 13:53:54 INFO - PROCESS | 12972 | _x_x_mozilla_page_load 13:53:54 INFO - PROCESS | 12972 | _x_x_mozilla_page_load_details 13:53:54 INFO - PROCESS | 12972 | |i|pagename|runs| 13:53:54 INFO - PROCESS | 12972 | |0;ai-astar;111;113;106;111;112;112;103;113;112;118 13:53:54 INFO - PROCESS | 12972 | |1;audio-beat-detection;169;133;153;173;138;156;147;133;174;136 13:53:54 INFO - PROCESS | 12972 | |2;audio-dft;162;162;164;164;165;161;163;165;162;161 13:53:54 INFO - PROCESS | 12972 | |3;audio-fft;73;73;87;91;71;72;72;124;91;72 13:53:54 INFO - PROCESS | 12972 | |4;audio-oscillator;98;96;132;97;98;98;138;96;97;134 13:53:54 INFO - PROCESS | 12972 | |5;imaging-gaussian-blur;109;109;111;109;109;109;109;110;110;109 13:53:54 INFO - PROCESS | 12972 | |6;imaging-darkroom;148;147;147;147;148;147;147;148;146;147 13:53:54 INFO - PROCESS | 12972 | |7;imaging-desaturate;95;95;95;96;96;95;96;96;96;95 13:53:54 INFO - PROCESS | 12972 | |8;json-parse-financial;70;69;71;70;70;70;70;82;69;70 13:53:54 INFO - PROCESS | 12972 | |9;json-stringify-tinderbox;68;69;68;68;69;68;69;69;70;69 13:53:54 INFO - PROCESS | 12972 | |10;stanford-crypto-aes;84;84;83;83;83;83;83;83;84;84 13:53:54 INFO - PROCESS | 12972 | |11;stanford-crypto-ccm;122;122;120;117;123;128;128;121;130;122 13:53:54 INFO - PROCESS | 12972 | |12;stanford-crypto-pbkdf2;142;153;152;152;164;140;151;149;149;139 13:53:54 INFO - PROCESS | 12972 | |13;stanford-crypto-sha256-iterative;71;71;74;71;72;72;70;71;70;70 13:53:54 INFO - PROCESS | 12972 | __end_tp_report 13:53:54 INFO - PROCESS | 12972 | __start_cc_report 13:53:54 INFO - PROCESS | 12972 | _x_x_mozilla_cycle_collect,1010 13:53:54 INFO - PROCESS | 12972 | __end_cc_report 13:53:54 INFO - PROCESS | 12972 | __startTimestamp1452376434692__endTimestamp 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | ------- Summary: start ------- 13:53:54 INFO - PROCESS | 12972 | Number of tests: 14 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:4.07 (3.6%) stddev-sans-first:4.31 13:53:54 INFO - PROCESS | 12972 | Values: 111.0 113.0 106.0 111.0 112.0 112.0 103.0 113.0 112.0 118.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:154.50 stddev:16.41 (10.6%) stddev-sans-first:16.09 13:53:54 INFO - PROCESS | 12972 | Values: 169.0 133.0 153.0 173.0 138.0 156.0 147.0 133.0 174.0 136.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.50 stddev:1.52 (0.9%) stddev-sans-first:1.58 13:53:54 INFO - PROCESS | 12972 | Values: 162.0 162.0 164.0 164.0 165.0 161.0 163.0 165.0 162.0 161.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#3] audio-fft Cycles:10 Average:82.60 Median:73.00 stddev:16.77 (23.0%) stddev-sans-first:17.42 13:53:54 INFO - PROCESS | 12972 | Values: 73.0 73.0 87.0 91.0 71.0 72.0 72.0 124.0 91.0 72.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:97.00 stddev:18.20 (18.8%) stddev-sans-first:18.91 13:53:54 INFO - PROCESS | 12972 | Values: 98.0 96.0 132.0 97.0 98.0 98.0 138.0 96.0 97.0 134.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 13:53:54 INFO - PROCESS | 12972 | Values: 109.0 109.0 111.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 13:53:54 INFO - PROCESS | 12972 | Values: 148.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 146.0 147.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:53:54 INFO - PROCESS | 12972 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#8] json-parse-financial Cycles:10 Average:71.10 Median:70.00 stddev:3.87 (5.5%) stddev-sans-first:4.09 13:53:54 INFO - PROCESS | 12972 | Values: 70.0 69.0 71.0 70.0 70.0 70.0 70.0 82.0 69.0 70.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 13:53:54 INFO - PROCESS | 12972 | Values: 68.0 69.0 68.0 68.0 69.0 68.0 69.0 69.0 70.0 69.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 13:53:54 INFO - PROCESS | 12972 | Values: 84.0 84.0 83.0 83.0 83.0 83.0 83.0 83.0 84.0 84.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:122.50 stddev:4.08 (3.3%) stddev-sans-first:4.30 13:53:54 INFO - PROCESS | 12972 | Values: 122.0 122.0 120.0 117.0 123.0 128.0 128.0 121.0 130.0 122.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:151.50 stddev:7.40 (4.9%) stddev-sans-first:7.39 13:53:54 INFO - PROCESS | 12972 | Values: 142.0 153.0 152.0 152.0 164.0 140.0 151.0 149.0 149.0 139.0 13:53:54 INFO - PROCESS | 12972 | 13:53:54 INFO - PROCESS | 12972 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.00 stddev:1.23 (1.7%) stddev-sans-first:1.30 13:53:54 INFO - PROCESS | 12972 | Values: 71.0 71.0 74.0 71.0 72.0 72.0 70.0 71.0 70.0 70.0 13:53:54 INFO - PROCESS | 12972 | -------- Summary: end -------- 13:53:54 INFO - PROCESS | 12972 | 13:53:55 INFO - TEST-INFO | 12972: exit 0 13:53:55 INFO - TEST-OK | kraken | took 60741ms 13:53:55 INFO - TEST-START | v8_7 13:53:55 INFO - operating with platform_type : linux_ 13:53:55 INFO - Initialising browser for v8_7 test... 13:53:55 INFO - TEST-INFO | started process 13220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo9XXjU/profile http://localhost:34959/getInfo.html) 13:54:00 INFO - PROCESS | 13220 | __metrics Screen width/height:1600/1200 13:54:00 INFO - PROCESS | 13220 | colorDepth:24 13:54:00 INFO - PROCESS | 13220 | Browser inner width/height: 1024/697 13:54:00 INFO - PROCESS | 13220 | __metrics 13:54:00 INFO - PROCESS | 13220 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:54:00 INFO - PROCESS | 13220 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:54:01 INFO - TEST-INFO | 13220: exit 0 13:54:01 INFO - Browser initialized. 13:54:01 INFO - Running cycle 1/1 for v8_7 test... 13:54:01 INFO - TEST-INFO | started process 13302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo9XXjU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:54:13 INFO - PROCESS | 13302 | RSS: Main: 148713472 13:54:13 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | Cycle 1(1): loaded http://localhost:34959/tests/v8_7/run.html (next: http://localhost:34959/tests/v8_7/run.html) 13:54:35 INFO - PROCESS | 13302 | RSS: Main: 438403072 13:54:35 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | __start_tp_report 13:54:35 INFO - PROCESS | 13302 | _x_x_mozilla_page_load 13:54:35 INFO - PROCESS | 13302 | _x_x_mozilla_page_load_details 13:54:35 INFO - PROCESS | 13302 | |i|pagename|runs| 13:54:35 INFO - PROCESS | 13302 | |0;Richards;167.000668002672 13:54:35 INFO - PROCESS | 13302 | |1;DeltaBlue;188.25301204819277 13:54:35 INFO - PROCESS | 13302 | |2;Encrypt;280.19052956010086 13:54:35 INFO - PROCESS | 13302 | |3;Decrypt;5164.948453608247 13:54:35 INFO - PROCESS | 13302 | |4;RayTrace;1984.126984126984 13:54:35 INFO - PROCESS | 13302 | |5;Earley;814.3322475570033 13:54:35 INFO - PROCESS | 13302 | |6;Boyer;12084.33734939759 13:54:35 INFO - PROCESS | 13302 | |7;RegExp;43382.97872340425 13:54:35 INFO - PROCESS | 13302 | |8;Splay;597.9689366786141 13:54:35 INFO - PROCESS | 13302 | |9;NavierStokes;4835.748792270531 13:54:35 INFO - PROCESS | 13302 | __end_tp_report 13:54:35 INFO - PROCESS | 13302 | __startTimestamp1452376475867__endTimestamp 13:54:35 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | ------- Summary: start ------- 13:54:35 INFO - PROCESS | 13302 | Number of tests: 10 13:54:35 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | [#0] Richards Cycles:1 Average:167.00 Median:167.00 stddev:0.00 (0.0%) 13:54:35 INFO - PROCESS | 13302 | Values: 167.0 13:54:35 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | [#1] DeltaBlue Cycles:1 Average:188.25 Median:188.25 stddev:0.00 (0.0%) 13:54:35 INFO - PROCESS | 13302 | Values: 188.3 13:54:35 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 13:54:35 INFO - PROCESS | 13302 | Values: 280.2 13:54:35 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 13:54:35 INFO - PROCESS | 13302 | Values: 5164.9 13:54:35 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 13:54:35 INFO - PROCESS | 13302 | Values: 1984.1 13:54:35 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | [#5] Earley Cycles:1 Average:814.33 Median:814.33 stddev:0.00 (0.0%) 13:54:35 INFO - PROCESS | 13302 | Values: 814.3 13:54:35 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | [#6] Boyer Cycles:1 Average:12084.34 Median:12084.34 stddev:0.00 (0.0%) 13:54:35 INFO - PROCESS | 13302 | Values: 12084.3 13:54:35 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | [#7] RegExp Cycles:1 Average:43382.98 Median:43382.98 stddev:0.00 (0.0%) 13:54:35 INFO - PROCESS | 13302 | Values: 43383.0 13:54:35 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | [#8] Splay Cycles:1 Average:597.97 Median:597.97 stddev:0.00 (0.0%) 13:54:35 INFO - PROCESS | 13302 | Values: 598.0 13:54:35 INFO - PROCESS | 13302 | 13:54:35 INFO - PROCESS | 13302 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 13:54:35 INFO - PROCESS | 13302 | Values: 4835.7 13:54:35 INFO - PROCESS | 13302 | -------- Summary: end -------- 13:54:35 INFO - PROCESS | 13302 | 13:54:36 INFO - TEST-INFO | 13302: exit 0 13:54:36 INFO - TEST-OK | v8_7 | took 41148ms 13:54:36 INFO - SUITE-END | took 1219s 13:54:36 INFO - Completed test suite (00:20:19) 13:54:36 INFO - Working with test: dromaeo_css 13:54:36 INFO - Generating results file: dromaeo_css 13:54:36 INFO - Working with test: kraken 13:54:36 INFO - Generating results file: kraken 13:54:36 INFO - javascript benchmark 13:54:36 INFO - Working with test: v8_7 13:54:36 INFO - Generating results file: v8_7 13:54:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:54:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 13:54:36 INFO - process_Request line: dromaeo_css 6090.00 graph.html#tests=[[72,203,35]] 13:54:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:54:36 INFO - process_Request line: kraken 1535.10 graph.html#tests=[[232,203,35]] 13:54:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:54:36 INFO - process_Request line: v8_7 18852.42 graph.html#tests=[[230,203,35]] 13:54:36 INFO - RETURN: dromaeo_css: 6090.00 13:54:36 INFO - RETURN: kraken: 1535.10 13:54:36 INFO - RETURN: v8_7: 18852.42 13:54:36 INFO - javascript benchmark 13:54:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2577.368544706547, 2665.40028493589, 2675.077098401051, 2687.543117669996, 2699.865006749663, 4294.441722576061, 4463.352813841991, 4468.240399132147, 4479.395281636982, 4480.887977800557, 4445.48876879159, 4482.417285752847, 4495.572920572548, 4519.435070616173, 4620.584147426731, 3953.98023009886, 4054.4729185205883, 4138.586141385852, 4172.645325147366, 4303.311470164775, 3992.4011398290345, 4245.15601471893, 4260.0, 4278.465191851019, 4289.978550107245, 4106.384042393635, 4109.753414795122, 4117.279476091687, 4194.30793919003, 4217.683673724483, 4143.461350024508, 4150.045489537393, 4156.896077598054, 4159.958400415987, 4191.580841915784, 4132.566080561528, 4142.150859073882, 4157.08544120293, 4165.812538435747, 4180.519240287375, 4254.106637606106, 4370.6940514164025, 4377.080813029268, 4389.692721509496, 4502.0, 4776.761161941924, 4815.277708343741, 4836.516348365135, 4836.564709176191, 4883.389576302962, 4841.443234028062, 4843.2250839865455, 4859.125357435661, 4863.902721945577, 4902.019596080798, 4365.738055716667, 4373.737575745466, 4452.265376212888, 4472.530384309665, 4481.619062379669, 4988.850334489971, 4988.850334489971, 4992.326035985168, 5008.248762685626, 5017.322661440732, 4770.689905156154, 4776.928346074812, 4783.569478746929, 4823.589994850477, 4834.20235661119, 4621.052684199731, 4744.027474367816, 4744.833930812405, 4853.757312134379, 4869.172240719086, 4683.414573178353, 4757.09615173116, 4759.333693282943, 4767.237242041326, 4791.664583479123, 4734.644901632391, 4769.165396055676, 4769.189237829577, 4772.284157376422, 4822.132016237041, 3879.709021823318, 3974.8410063597134, 3976.4631774710624, 4038.7778672172726, 4074.7758873262255, 3533.7703049301713, 3578.1949061461482, 3621.9094522637147, 3624.0577449863226, 3638.490611314418, 4126.319157339006, 4127.236461254677, 4140.275451795924, 4160.854370097032, 4188.120494696087, 4607.746573938399, 4750.239961606127, 4785.210440277385, 4785.976070119627, 4844.636652251025, 4030.133521292936, 4048.352263637804, 4140.068484591003, 4222.683298752544, 4240.342746874239, 4260.467441569804, 4293.355996600472, 4296.291111966553, 4328.069465065026, 4338.978305108454, 4499.460064792246, 4609.847538115471, 4611.354410382549, 4612.884677883079, 4656.022235330618, 4700.106979673988, 4724.811007559797, 4731.219348807408, 4832.637552183671, 4833.879153021062, 4567.566081222279, 4591.701539399928, 4593.839215627437, 4596.816127355002, 4631.050634619962, 4712.434507859079, 4724.645651576215, 4731.550502702238, 4736.786844591933, 4764.666473346832, 4639.744814035125, 4764.213904705684, 4776.641751868554, 4786.7845946931775, 4790.233562629963, 4709.270063140219, 4717.2216584263215, 4718.433787945469, 4722.150012997693, 4759.6430267729365, 4684.672072954861, 4689.835855745169, 4696.365990591226, 4711.505291944297, 4747.264174053027, 4436.82252709888, 4539.228331183641, 4541.114482675846, 4620.075984802986, 4627.8611641650805, 4655.30170474418, 4737.644676649334, 4770.594499467584, 4783.354247176726, 4786.904261914812, 4566.041131362451, 4568.840090596813, 4572.177008138567, 4573.474050484237, 4608.562186592402], "unit": "score", "name": "dojo.html", "value": 4418.656222162448}, {"lowerIsBetter": false, "replicates": [477.3746392226184, 495.5861855350782, 505.5854199556364, 507.08471209466944, 512.1344927073246, 24776.87611561942, 25202.0, 33118.66881331186, 33167.0, 33285.833570832176, 36539.634603653954, 36856.63143368565, 37029.62970370296, 37228.81385593075, 37250.0, 6757.121574195372, 6870.1068861048, 7532.397408207344, 7710.151883292833, 7712.113106992683, 9520.190783783386, 9646.180074693659, 9726.610935562569, 9737.415755054684, 9739.123478886899, 9171.678991235309, 9250.907490925072, 9262.444253344787, 9268.675596354129, 9271.443713377184, 6880.8967865482055, 7066.293370662944, 7069.222385537587, 7082.575045497287, 9270.397424167408, 6807.3873351398615, 9492.762680932963, 9716.562754676057, 9731.318807683465, 9738.659146929824, 32838.34323313544, 33219.33561328784, 33251.0, 33311.16722081943, 33325.16687082818, 2776.3891943772337, 2858.399736055431, 2965.6144701188923, 3115.2523394385184, 3461.117415059169, 24358.14746483882, 24585.631215531783, 24668.87665561661, 24861.87569062143, 24984.625230621554, 3339.8497067632015, 3447.5345828313107, 3503.7021853142514, 3536.840842162109, 3544.043108360754, 214481.0, 216301.0, 216467.0, 216540.0, 217017.0, 55509.0, 55952.44047559554, 56157.71921140368, 56185.15722264169, 56201.43798562044, 58449.70775146182, 58636.706816465645, 58785.706071470224, 58981.705091474265, 59065.0, 13824.723505529833, 14171.433142674177, 14338.426462941365, 14414.279286035657, 14557.0, 11437.771244575062, 11561.479733412016, 11565.074794016627, 11565.363904985306, 11582.36297003673, 18707.0, 18878.811211887707, 18901.81098189028, 18943.0, 18976.0, 7326.413886889036, 7584.696612135564, 7595.088589369311, 7626.313631773167, 7724.7682569523, 807.4025221336169, 809.7489778168787, 890.4612709310903, 914.5427286356821, 940.8965013848472, 23069.07723691067, 23145.0, 23285.0, 23291.88354058219, 23309.650355244685, 897.2463130970017, 944.1313991128178, 944.593824655391, 944.8535477001076, 1004.7387679203459, 11855.288682679067, 12238.877611223774, 12502.124851260507, 12573.0, 12667.239965602093, 318766.0, 321682.0, 322391.0, 323554.0, 324073.0, 47483.0, 47731.76134119307, 47748.28377574339, 47866.52133478621, 47877.76061119672, 1159.878212787662, 1166.8891455311732, 1173.9706507337385, 1175.2067354535654, 1193.9283642981623, 25523.489530209663, 26302.736972630028, 26623.600645990715, 26827.597586035834, 26840.194794156207, 42223.57776422196, 42923.35614965716, 42925.0, 43008.0, 43039.354409683256, 247214.0, 247339.0, 247575.0, 247984.0, 248124.0, 34409.311813764085, 34748.65251347454, 35264.0, 37874.242515150094, 38455.0, 34616.0, 34784.65215347814, 34802.303953921284, 34906.47640285347, 35728.10679733028, 32401.0, 32474.35051299008, 32968.0, 33310.66689333173, 34035.319293613495, 26162.476750465266, 34420.31159376748, 35850.46224306586, 38625.42061869131, 39068.804655976535, 32942.0, 33105.172370690925, 33115.66884331126, 33282.667173328926, 33460.1634959128, 29044.12867613975, 29127.12618621445, 29510.704892950795, 29574.852125740093, 29691.85154074216, 22858.885705571367, 23127.76872231256, 23174.652380214648, 23251.18620848262, 23402.76597234074], "unit": "score", "name": "ext.html", "value": 16841.118356881583}, {"lowerIsBetter": false, "replicates": [321.95492631031647, 336.34748587739784, 338.7544030577831, 340.6287147009759, 342.91084318077293, 11998.0, 12438.378081095954, 14435.278236088194, 14813.259337033145, 15091.547253582396, 8376.706815261467, 9687.467189304585, 9979.900200997989, 12975.74048519029, 15210.467633632825, 4372.519022907478, 4576.83981060663, 4577.793999270041, 4578.244589642705, 4583.014651849851, 3286.7699261051735, 3409.181796368866, 3410.880619178329, 3412.385770561298, 4320.56794320567, 3406.3017081498356, 3407.4207384744655, 4901.0, 5082.720450375228, 5083.949160508403, 5049.2678561608545, 5114.590832733391, 5709.143628455702, 5712.0, 5712.257406537124, 4824.879378015543, 5057.165567681328, 5073.0107629012355, 5074.086664400406, 5075.619328550373, 11468.598599049077, 11599.6520104397, 11602.361870097142, 11617.88382116185, 13479.0, 1663.1767275198854, 1703.403808666969, 1746.3974928649595, 1768.2838450427598, 1831.9267229310813, 8435.95782021086, 8538.316934645276, 8845.601947912359, 10590.523426445752, 12617.179883307555, 1759.876808623397, 1769.3630293094475, 1785.431198478125, 1799.8560115190753, 1821.836034756865, 49440.50559494395, 49774.75112624414, 50561.0, 51023.234651480256, 51319.48680513222, 9638.373505722106, 9694.418334899929, 9720.416774993522, 9738.36700614472, 9779.168770654574, 12329.075319351085, 12329.198602090835, 12333.198342107735, 12334.383280835922, 12336.938315308545, 6704.0, 6721.899171512431, 6812.557183783138, 6830.31696830313, 6961.756338528127, 6522.608643481406, 6543.083968244449, 6824.21521525021, 6875.449964002868, 6889.621070841152, 4059.6752259819737, 4133.607307305801, 4149.566803465577, 4181.059261666101, 4194.035371864488, 1646.2345009570606, 1683.452877814715, 1685.1405783050486, 1704.6675898199733, 1777.1380880273057, 746.608030783832, 800.6557180412478, 803.8593246181895, 852.2117041736369, 877.3288434347729, 14587.416503339748, 14706.926465367605, 15138.016028958082, 15378.538643840702, 15423.305951232222, 762.7139822566537, 822.8642274024719, 825.6862392291011, 838.1283465196128, 883.1212943121635, 8029.437939344307, 8264.132266112092, 8382.742588611634, 8399.538025408661, 8570.614322355508, 304352.0, 309783.4510827431, 309881.0, 310204.0, 423262.0, 60373.396266036776, 64853.0, 66950.63543010264, 67344.66327668428, 69955.73496937362, 1041.250299784154, 1060.061845266929, 1060.6287799270194, 1070.7323169207698, 1082.7888561730388, 13684.399964006807, 13813.171209727449, 14128.50550230737, 14219.217943013233, 14296.356663949939, 30289.848550757106, 31050.378992420476, 31266.687333127287, 31383.529247061768, 31415.21461963469, 40393.79803101083, 40432.79783601063, 40444.1911161781, 40641.18717625572, 41452.79273603613, 6347.143135676624, 6439.388258115471, 6487.18910136233, 6549.4760419167305, 6652.7006284716335, 7844.372450203856, 9733.707988760349, 9751.80496390054, 9890.258230632875, 9953.651622193189, 8203.466774659628, 8238.258556729923, 8249.958750206211, 8264.21489958453, 8398.580070996548, 8786.516741579275, 8927.062658421031, 8972.19250267479, 9089.954550227207, 9143.817123657622, 6074.218361789662, 7092.503524753424, 8020.438569300093, 8226.712065077932, 8626.18051285127, 6456.192975878015, 6737.292584278776, 6757.054012438361, 6778.627175505198, 6876.828079298058, 6780.559263647847, 8071.4753541019645, 8087.676492940452, 8116.107228204774, 8178.918210818054], "unit": "score", "name": "jquery.html", "value": 7107.89263136709}, {"lowerIsBetter": false, "replicates": [1196.1626861197165, 1404.6277736399852, 1412.6892083741577, 1556.7898333724943, 1761.4363403710818, 6084.391560843919, 6938.444924406048, 7117.110361204849, 7122.180949190844, 7126.3942564882045, 7173.605451700168, 7363.41092712583, 7368.373688236493, 7370.815729606763, 7374.225706300828, 2143.9892800536013, 2166.068590506082, 2168.30614203455, 2169.1215057901577, 2169.6853956176346, 2069.6998935154393, 2110.8522403431766, 2165.0257384177185, 2165.9241926532573, 2183.9890800545977, 2115.6086124067097, 2118.0680500579774, 2129.361191642509, 2129.7870212978733, 2180.1279488204764, 2151.4728891421546, 2159.6112699714045, 2160.7191065161587, 2161.1787520742096, 2167.804897559219, 2111.7465904091455, 2159.967600485994, 2167.0248388225364, 2168.111074459464, 2169.013099039949, 7577.5453472791805, 7625.466217364787, 7625.961870190614, 7637.809054773675, 7643.541387516767, 4193.077522944947, 4263.59495847894, 4268.701190916637, 4292.656587472995, 4303.053328267776, 2857.39994601134, 2889.754370878478, 2989.7458716009164, 2993.476141675198, 3013.8794448222043, 845.7674139611595, 852.6845067325067, 876.3646356391629, 888.2006194425069, 890.3366991591306, 10506.474676266233, 10511.579536818517, 10511.947440262826, 10519.421431821247, 10524.631637892637, 4018.3168861293652, 4028.6374226319185, 4093.1813637272667, 4124.90689967159, 4126.711130220856, 9014.86477702835, 9017.098290171061, 9020.639174433081, 9023.278137748965, 9023.323250756219, 4362.825486980485, 4372.890677733082, 4374.300111982131, 4375.321825117112, 4377.9781101094295, 3269.0519749272444, 3373.224158443572, 3856.2865869814173, 3950.20995800841, 3953.4267531207815, 3477.2871561329866, 3507.7719948203285, 3524.665156810099, 3535.292941411728, 3559.039059453985, 1063.6862125672944, 1092.5192915117323, 1093.3002878157986, 1101.895319944604, 1104.817705078653, 1185.8280549320473, 1206.2460961898814, 1208.456194712383, 1221.9144659873723, 1225.8345123408226, 7066.646667666596, 7074.398676112485, 7205.207427183006, 7217.206107328189, 7233.529820561646, 1000.9299349045497, 1016.6289304403839, 1028.9742756430999, 1033.8397548380012, 1034.1881622925966, 5531.502164805106, 5532.30846144232, 5537.833864984057, 5602.159676048625, 5603.131514615241, 8837.60230789616, 8948.060453652402, 9218.63125474987, 9281.489518076436, 9295.76760580991, 9211.723648290563, 9493.572789224501, 9494.810103798023, 9497.477638729937, 9506.572204250826, 6989.650517474106, 7025.262347453546, 7213.963930180315, 7345.853082938312, 7346.595937223504, 6899.965500172668, 6940.7917762467205, 6978.79063628092, 6987.475939304674, 6990.440764738911, 8215.09633940278, 8325.875111873447, 8415.368847336353, 8438.367122465717, 8547.615357308812, 7846.960765196138, 8011.719589814562, 8016.559089250147, 8106.797330066795, 8126.715564955434, 5349.144136938071, 5481.725913704219, 5483.067878460751, 6396.232452105591, 6544.411003009752, 5580.386157522588, 5652.2086907833755, 6757.898631520433, 6898.379145876896, 6924.826879328057, 6231.781887633911, 6583.506237032146, 6634.137562116894, 6651.833704157241, 6668.633225172662, 6410.5192110592825, 6414.5189110815945, 6472.449841763503, 6580.76967306142, 6654.170103221652, 6626.933730662631, 6687.76592819249, 6690.431313338226, 6692.297308782702, 6698.196216454056, 6123.7550497981365, 6166.229221347332, 6178.289496707756, 6195.845103872439, 6219.440250377488, 6057.394260574084, 6107.6640784757265, 6115.908261375994, 6122.785702500391, 6244.594101383395], "unit": "score", "name": "mootools.html", "value": 4241.49959484248}, {"lowerIsBetter": false, "replicates": [302.61416693715523, 309.60370725471404, 314.529777981917, 318.7672998710941, 326.7843223472508, 5201.349831271091, 5284.841454756353, 5326.6537675051095, 5343.946560534394, 5346.9732651336735, 5222.164453687411, 5249.317588713471, 5253.816116435925, 5257.0, 5266.552343050836, 3883.650471457568, 3978.3037968355566, 4090.0797320602924, 4099.405586190001, 4101.097758493134, 4035.2131334389805, 4162.209180255742, 4164.146349998258, 4164.604362585549, 4185.644220241283, 4133.607307305801, 4134.958650413502, 4138.234426631083, 4139.958600414003, 4146.6268035876765, 3849.711271654623, 4001.419794129835, 4039.6768258539246, 4127.133302006582, 4141.81361838718, 3672.3940549809518, 3676.1361080146144, 3680.2823449427374, 3688.704903607705, 3690.6309369063147, 5120.027194833007, 5128.820491282787, 5129.9743501282255, 5135.537801597837, 5149.639525233235, 4778.307145463888, 4789.066132104241, 4793.664443488957, 4796.664233503656, 4802.06359759847, 5441.646292990982, 5564.777408903679, 5578.135389014709, 5584.357798853143, 5586.776528938837, 4012.0772222388723, 4013.13717550728, 4015.819288132012, 4017.959820401788, 4020.718549701522, 5836.737346819404, 5841.824745257649, 5845.649261044351, 5849.005669036274, 5849.941500584982, 4146.274401979702, 4153.314703074019, 4154.646855017297, 4155.4182414462, 4156.480439945007, 4112.670986321087, 4213.220554197484, 4231.048014196781, 4237.915241695149, 4243.893902652459, 4766.118268120409, 4767.070421267819, 4769.070031343855, 4780.880477988078, 4780.880477988078, 5570.777168913279, 5580.302462192226, 5581.469760372839, 5581.665100094007, 5586.1062230043, 1462.90491118077, 1500.8123984501938, 1502.6318551954841, 1502.9098254104788, 1504.1050574907913, 1032.5353590884133, 1037.190991027, 1039.4854546999134, 1048.4705223861902, 1065.5524679634573, 4853.174960256765, 4868.391451068616, 4868.707877527359, 4870.951290487121, 4874.658773885794, 5756.3380211276235, 5761.942380576224, 5767.596268261182, 5770.163326317745, 5772.3938986406665, 4855.198892182751, 4863.683860549053, 4864.78108485119, 4871.926921096187, 4876.21980483121, 2876.266552029219, 2942.8969986050383, 3048.8932887348838, 3079.5226739855357, 3111.8910838120555, 5456.6725996439545, 5550.056490396642, 5555.0834112371, 5555.444455554493, 5569.582281328917, 5992.370801065826, 5993.910091348634, 6009.969950150309, 6011.398860113954, 6011.458968692838, 5554.416786237468, 5557.916631250615, 5559.082751345983, 5561.694106824163, 5568.693721845338, 5623.268975033219, 5800.680962546931, 5819.883602328015, 5838.0, 5861.443162899518, 5678.346990096192, 5699.2590963174525, 5733.426657334233, 5737.340205876378, 5748.712564371681, 5538.224648549126, 5545.750441230235, 5546.195801608825, 5550.47270509301, 5551.028570000314, 4027.7583344999393, 4138.172365526846, 4185.058361868555, 4186.644135248538, 4189.748615083105, 5697.800576979952, 5774.393688662798, 5775.942240577709, 5780.450857168562, 5780.479756821906, 5556.138798486241, 5558.194061861089, 5558.666480011212, 5559.8888022240135, 5562.638428502134, 5497.092979658471, 5572.85756419941, 5574.665520068809, 5585.916211256916, 5586.301712285965, 5360.624756267024, 5453.64551304164, 5466.562674985912, 5468.644538105011, 5475.863103422446, 5586.944130558805, 5589.888202236014, 5592.02139625572, 5596.160575913483, 5603.439656034364, 5280.0, 5313.521783039545, 5405.567554595702, 5437.075697131576, 5437.3747019091725], "unit": "score", "name": "prototype.html", "value": 4230.212990647623}, {"lowerIsBetter": false, "replicates": [560.6439910656732, 616.3528295289944, 636.9681515924202, 689.5965859971916, 725.1407082607109, 10786.67639970801, 10913.672589822298, 10923.235373523856, 10953.83569246462, 10967.232293739442, 10516.522552463211, 10539.789204215911, 10646.78706425871, 10658.733531661712, 10660.520276587553, 609.9817005489842, 616.3312805605923, 751.5753599216439, 756.1380026769488, 767.4589414462819, 766.2988365645427, 771.4407054885191, 773.1456740301969, 773.215186585616, 773.3967505345811, 629.7134803664321, 795.0300633227482, 803.9276465118138, 805.5770720371822, 806.4193780478047, 633.3856159525253, 634.0236036503778, 636.0078277886489, 636.8789929913302, 769.9538027718298, 578.4967078641566, 579.5016285994042, 580.4949693766408, 583.270911360799, 584.4097461563808, 10660.307080039773, 10705.785884282348, 10721.83917241242, 10722.839157412645, 10726.839097413545, 10907.872964771872, 11272.43637818114, 11412.20114591979, 11426.428678566039, 11477.311361318347, 8866.113388661146, 9154.771130721718, 9253.398529095588, 9297.535123243812, 9417.105374989365, 3170.1599076244815, 3214.758893083028, 3229.418704633165, 3236.3689080629288, 3253.398121347558, 37330.253394932224, 37728.24543509142, 38570.0, 38706.225875482334, 38731.60928446803, 9209.723708288628, 9219.90780092204, 9226.446413215228, 9292.16370526656, 9301.53492325381, 16049.518514444586, 16089.839101608834, 16114.677706445806, 16134.112623805804, 16146.434874779561, 6044.455998960027, 6193.256809182837, 6415.390537898892, 6570.474362051024, 6578.76974305897, 3456.9308613827584, 3565.2512972276113, 3568.3398571264397, 3619.059044648358, 3619.2580520993133, 2594.0, 2616.175904590048, 2629.7501737334924, 2632.9078482253412, 2641.696204936457, 448.24694513218105, 462.5628780802177, 467.7427414921779, 473.6211031175046, 474.2577865640262, 419.43585876995394, 466.7829459301373, 513.383939272874, 579.6348300570697, 585.1602949767098, 6835.7949261522235, 6856.314368563204, 7056.964715176391, 7127.2160062393095, 7134.072570565793, 453.1955778493135, 455.80856040463084, 571.8055861007277, 594.5273507561499, 623.329920335641, 3249.3988612106837, 3359.5128706337446, 3380.5267262583257, 3409.8636054558037, 3449.827508624609, 44528.0, 45360.77319613381, 45783.313250301275, 46053.77623566318, 46192.0, 40266.194676106315, 40756.0, 40846.79576602098, 41109.58890411058, 41114.79442602768, 37490.0, 38040.42939355912, 38083.619163808005, 38333.808330958724, 38466.0, 7457.142428620561, 7556.848863022598, 7567.545947243183, 7576.962115189609, 7721.5753133575945, 29481.410371792874, 29541.55687664644, 29827.552586711652, 31004.534931975588, 31062.22344441317, 36829.26341473209, 37420.81289593535, 37454.6254537462, 37670.0, 37713.62286377101, 9205.355625106446, 9661.547042769675, 9883.30816842814, 9987.450690212108, 10069.69790906274, 11064.557417703201, 11077.169212308949, 11098.0, 11100.167487438313, 11281.32312061279, 9529.237660986966, 9981.0, 10000.699979000641, 10065.993400659876, 10213.438260895722, 9655.08276713711, 9728.124468797841, 10074.748131296776, 10489.055984961391, 10638.202134839763, 7734.922650773646, 9894.703158905244, 9919.801603967735, 10249.282550221413, 10297.3821570706, 8033.6786528538205, 8053.516788992679, 8068.596570171585, 8461.40770146084, 8548.786280343042, 8129.75610731679, 8193.795155120932, 8472.44929079608, 8521.91478085236, 8716.651333946826], "unit": "score", "name": "yui.html", "value": 5374.956993525886}], "name": "dromaeo_css", "value": 6089.995430653322}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 106.0, 111.0, 112.0, 112.0, 103.0, 113.0, 112.0, 118.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [169.0, 133.0, 153.0, 173.0, 138.0, 156.0, 147.0, 133.0, 174.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 151.2}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 164.0, 164.0, 165.0, 161.0, 163.0, 165.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 87.0, 91.0, 71.0, 72.0, 72.0, 124.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 132.0, 97.0, 98.0, 98.0, 138.0, 96.0, 97.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 111.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 70.0, 70.0, 70.0, 70.0, 82.0, 69.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [122.0, 122.0, 120.0, 117.0, 123.0, 128.0, 128.0, 121.0, 130.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [142.0, 153.0, 152.0, 152.0, 164.0, 140.0, 151.0, 149.0, 149.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.1}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 74.0, 71.0, 72.0, 72.0, 70.0, 71.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1535.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.000668002672], "unit": "score", "name": "Richards", "value": 211.38837599999997}, {"lowerIsBetter": false, "replicates": [188.25301204819277], "unit": "score", "name": "DeltaBlue", "value": 351.2188160000002}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [814.3322475570033], "unit": "score", "name": "Earley", "value": 818.4165640000001}, {"lowerIsBetter": false, "replicates": [12084.33734939759], "unit": "score", "name": "Boyer", "value": 55.150976071784655}, {"lowerIsBetter": false, "replicates": [43382.97872340425], "unit": "score", "name": "RegExp", "value": 20.998673369298682}, {"lowerIsBetter": false, "replicates": [597.9689366786141], "unit": "score", "name": "Splay", "value": 136.27965434565436}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 18852.424029996906}]} 13:54:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "18852.42"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1535.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6090.00"}}} 13:54:37 INFO - Return code: 0 13:54:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:54:37 INFO - # TBPL SUCCESS # 13:54:37 INFO - Running post-action listener: _resource_record_post_action 13:54:37 INFO - Running post-run listener: _resource_record_post_run 13:54:38 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 557105152; Read time: 0; Write time: 505308 13:54:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238379008; Read time: 0; Write time: 274608 13:54:38 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 317861888; Read time: 0; Write time: 230664 13:54:38 INFO - Running post-run listener: _upload_blobber_files 13:54:38 INFO - Blob upload gear active. 13:54:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:54:38 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 13:54:38 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', 'B2G-Inbound-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:54:38 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 B2G-Inbound-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:54:38 INFO - (blobuploader) - INFO - Open directory for files ... 13:54:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:54:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:54:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:39 INFO - (blobuploader) - INFO - Done attempting. 13:54:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:54:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:54:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:40 INFO - (blobuploader) - INFO - Done attempting. 13:54:40 INFO - (blobuploader) - INFO - Iteration through files over. 13:54:40 INFO - Return code: 0 13:54:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:54:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:54:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/aba51a13bb6c4eecabdebcb348655611c0378a768a430a6dc2a48fc918426f6be3b5d54d7bd02f130cc21354a734c44be7b3986027a77d4433a65fc4ab5da8c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/ef0dd4925881ea43f9da6083bb5e5a44f560a9f96ba0b8b3ae59fe3332387755a412f7388456badb7c765f15da1fae2944d534ee7b6cf1c108d81be1c31cce4d"} 13:54:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:54:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:54:40 INFO - Contents: 13:54:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/aba51a13bb6c4eecabdebcb348655611c0378a768a430a6dc2a48fc918426f6be3b5d54d7bd02f130cc21354a734c44be7b3986027a77d4433a65fc4ab5da8c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/ef0dd4925881ea43f9da6083bb5e5a44f560a9f96ba0b8b3ae59fe3332387755a412f7388456badb7c765f15da1fae2944d534ee7b6cf1c108d81be1c31cce4d"} 13:54:40 INFO - Copying logs to upload dir... 13:54:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1275.071092 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-09 13:54:39.245122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 13:54:39.248937) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/aba51a13bb6c4eecabdebcb348655611c0378a768a430a6dc2a48fc918426f6be3b5d54d7bd02f130cc21354a734c44be7b3986027a77d4433a65fc4ab5da8c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/ef0dd4925881ea43f9da6083bb5e5a44f560a9f96ba0b8b3ae59fe3332387755a412f7388456badb7c765f15da1fae2944d534ee7b6cf1c108d81be1c31cce4d"} build_url:https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/Uy56Jgv_TFyd_tEk2MuFPw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/aba51a13bb6c4eecabdebcb348655611c0378a768a430a6dc2a48fc918426f6be3b5d54d7bd02f130cc21354a734c44be7b3986027a77d4433a65fc4ab5da8c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/ef0dd4925881ea43f9da6083bb5e5a44f560a9f96ba0b8b3ae59fe3332387755a412f7388456badb7c765f15da1fae2944d534ee7b6cf1c108d81be1c31cce4d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 13:54:39.273403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:54:39.273747) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452375062.383430-616117225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 13:54:39.356525) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 13:54:39.356847) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 13:54:39.357153) ========= ========= Total master_lag: 0.23 =========