builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1450702486.53 results: success (0) buildid: 20151221041538 builduid: 4f963dc31fa64ccdacb591b1c83fdaea revision: 03f6b2915b9fe1a8df03f8256fd4b8235535f216 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.535249) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.535993) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.536277) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006354 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.559019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.559286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.572909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.573161) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004731 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.625992) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.626246) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.626573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.626838) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 04:54:46-- 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% 222M=0s 2015-12-21 04:54:46 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.833650) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.833991) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015435 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.884875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:46.885196) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 03f6b2915b9fe1a8df03f8256fd4b8235535f216 --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 03f6b2915b9fe1a8df03f8256fd4b8235535f216 --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=49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 04:54:47,003 truncating revision to first 12 chars 2015-12-21 04:54:47,003 Setting DEBUG logging. 2015-12-21 04:54:47,003 attempt 1/10 2015-12-21 04:54:47,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/03f6b2915b9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 04:54:47,259 unpacking tar archive at: b2g-inbound-03f6b2915b9f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538033 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:47.436632) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:47.436899) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:47.444381) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:47.444633) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 04:54:47.444999) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-21 04:54:47.445367) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:54:47 INFO - MultiFileLogger online at 20151221 04:54:47 in /builds/slave/test 04:54:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 04:54:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:54:47 INFO - {'append_to_log': False, 04:54:47 INFO - 'base_work_dir': '/builds/slave/test', 04:54:47 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 04:54:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:54:47 INFO - 'branch': 'B2G-Inbound-Non-PGO', 04:54:47 INFO - 'buildbot_json_path': 'buildprops.json', 04:54:47 INFO - 'config_files': ('talos/linux_config.py',), 04:54:47 INFO - 'default_actions': ('clobber', 04:54:47 INFO - 'read-buildbot-config', 04:54:47 INFO - 'download-and-extract', 04:54:47 INFO - 'populate-webroot', 04:54:47 INFO - 'create-virtualenv', 04:54:47 INFO - 'install', 04:54:47 INFO - 'run-tests'), 04:54:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:54:47 INFO - 'download_minidump_stackwalk': True, 04:54:47 INFO - 'download_symbols': 'ondemand', 04:54:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:54:47 INFO - 'tooltool.py': '/tools/tooltool.py', 04:54:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:54:47 INFO - '/tools/misc-python/virtualenv.py')}, 04:54:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:54:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:54:47 INFO - 'installer_path': 'installer.exe', 04:54:47 INFO - 'log_level': 'info', 04:54:47 INFO - 'log_name': 'talos', 04:54:47 INFO - 'log_to_console': True, 04:54:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:54:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:54:47 INFO - 'opt_config_files': (), 04:54:47 INFO - 'pip_index': False, 04:54:47 INFO - 'sps_profile': False, 04:54:47 INFO - 'sps_profile_interval': 0, 04:54:47 INFO - 'suite': 'dromaeojs', 04:54:47 INFO - 'system_bits': '64', 04:54:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:54:47 INFO - 'title': 'talos-linux64-ix-060', 04:54:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:54:47 INFO - 'use_talos_json': True, 04:54:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:54:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:54:47 INFO - 'work_dir': 'build'} 04:54:47 INFO - ##### 04:54:47 INFO - ##### Running clobber step. 04:54:47 INFO - ##### 04:54:47 INFO - Running pre-action listener: _resource_record_pre_action 04:54:47 INFO - Running main action method: clobber 04:54:47 INFO - rmtree: /builds/slave/test/build 04:54:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:54:48 INFO - Running post-action listener: _resource_record_post_action 04:54:48 INFO - ##### 04:54:48 INFO - ##### Running read-buildbot-config step. 04:54:48 INFO - ##### 04:54:48 INFO - Running pre-action listener: _resource_record_pre_action 04:54:48 INFO - Running main action method: read_buildbot_config 04:54:48 INFO - Using buildbot properties: 04:54:48 INFO - { 04:54:48 INFO - "project": "", 04:54:48 INFO - "product": "firefox", 04:54:48 INFO - "script_repo_revision": "production", 04:54:48 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:54:48 INFO - "repository": "", 04:54:48 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 04:54:48 INFO - "buildid": "20151221041538", 04:54:48 INFO - "pgo_build": "False", 04:54:48 INFO - "basedir": "/builds/slave/test", 04:54:48 INFO - "buildnumber": 315, 04:54:48 INFO - "slavename": "talos-linux64-ix-060", 04:54:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:54:48 INFO - "platform": "ubuntu64_hw", 04:54:48 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 04:54:48 INFO - "branch": "b2g-inbound", 04:54:48 INFO - "repo_path": "integration/b2g-inbound", 04:54:48 INFO - "revision": "03f6b2915b9fe1a8df03f8256fd4b8235535f216", 04:54:48 INFO - "stage_platform": "linux64", 04:54:48 INFO - "builduid": "4f963dc31fa64ccdacb591b1c83fdaea", 04:54:48 INFO - "slavebuilddir": "test" 04:54:48 INFO - } 04:54:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:54:48 INFO - Running post-action listener: _resource_record_post_action 04:54:48 INFO - ##### 04:54:48 INFO - ##### Running download-and-extract step. 04:54:48 INFO - ##### 04:54:48 INFO - Running pre-action listener: _resource_record_pre_action 04:54:48 INFO - Running main action method: download_and_extract 04:54:48 INFO - mkdir: /builds/slave/test/build/tests 04:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:48 INFO - https://queue.taskcluster.net/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:54:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/test_packages.json 04:54:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/test_packages.json 04:54:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:54:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:54:52 INFO - Downloaded 1302 bytes. 04:54:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:54:52 INFO - Using the following test package requirements: 04:54:52 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:52 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:54:52 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:52 INFO - u'jsshell-linux-x86_64.zip'], 04:54:52 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:54:52 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:52 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:54:52 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:54:52 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:54:52 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:54:52 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:54:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:54:52 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:52 INFO - https://queue.taskcluster.net/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:54:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:54:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:54:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/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 04:54:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/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 04:54:53 INFO - Downloaded 21926344 bytes. 04:54:53 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 04:54:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:54:53 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 04:54:54 INFO - Return code: 0 04:54:54 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 04:54: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')]} 04:54:54 INFO - https://queue.taskcluster.net/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:54:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:54:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:54:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/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 04:54:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/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 04:54:56 INFO - Downloaded 21926344 bytes. 04:54:56 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 04:54:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:54:56 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 04:54:58 INFO - Return code: 0 04:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:58 INFO - https://queue.taskcluster.net/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:54:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/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 04:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/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 04:54:58 INFO - Downloaded 11132277 bytes. 04:54:58 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 04:54:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:54:58 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 04:54:59 INFO - Return code: 0 04:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:54:59 INFO - https://queue.taskcluster.net/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:54:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:54:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:54:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/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 04:54:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wdNZ650RS8erOkzuqRvZjw/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 04:55:00 INFO - Downloaded 53382932 bytes. 04:55:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:55:00 INFO - mkdir: /builds/slave/test/properties 04:55:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:55:00 INFO - Writing to file /builds/slave/test/properties/build_url 04:55:00 INFO - Contents: 04:55:00 INFO - build_url:https://queue.taskcluster.net/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:55:00 INFO - Running post-action listener: _resource_record_post_action 04:55:00 INFO - Running post-action listener: set_extra_try_arguments 04:55:00 INFO - ##### 04:55:00 INFO - ##### Running populate-webroot step. 04:55:00 INFO - ##### 04:55:00 INFO - Running pre-action listener: _resource_record_pre_action 04:55:00 INFO - Running main action method: populate_webroot 04:55:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:55:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:55:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:55:00 INFO - '--tppagecycles', 04:55:00 INFO - '7'], 04:55:00 INFO - 'tests': ['tsvgm']}}, 04:55:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:55:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:55:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:55:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:55:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:55:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:55:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:00 INFO - 'talos_options': ['--e10s'], 04:55:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:00 INFO - 'tests': ['damp', 'tps']}, 04:55:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:00 INFO - 'talos_options': ['--e10s'], 04:55:00 INFO - 'tests': ['damp', 'tps']}, 04:55:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:55:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:55:00 INFO - 'other': {'tests': ['a11yr', 04:55:00 INFO - 'ts_paint', 04:55:00 INFO - 'tpaint', 04:55:00 INFO - 'sessionrestore', 04:55:00 INFO - 'sessionrestore_no_auto_restore']}, 04:55:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:55:00 INFO - 'tests': ['a11yr', 04:55:00 INFO - 'ts_paint', 04:55:00 INFO - 'tpaint', 04:55:00 INFO - 'sessionrestore', 04:55:00 INFO - 'sessionrestore_no_auto_restore']}, 04:55:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:55:00 INFO - 'tests': ['a11yr', 04:55:00 INFO - 'ts_paint', 04:55:00 INFO - 'tpaint', 04:55:00 INFO - 'sessionrestore', 04:55:00 INFO - 'sessionrestore_no_auto_restore']}, 04:55:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:55:00 INFO - 'tests': ['a11yr', 04:55:00 INFO - 'ts_paint', 04:55:00 INFO - 'tpaint', 04:55:00 INFO - 'sessionrestore', 04:55:00 INFO - 'sessionrestore_no_auto_restore']}, 04:55:00 INFO - 'other_l64': {'tests': ['a11yr', 04:55:00 INFO - 'ts_paint', 04:55:00 INFO - 'tpaint', 04:55:00 INFO - 'sessionrestore', 04:55:00 INFO - 'sessionrestore_no_auto_restore']}, 04:55:00 INFO - 'other_nol64': {'tests': ['a11yr', 04:55:00 INFO - 'ts_paint', 04:55:00 INFO - 'tpaint', 04:55:00 INFO - 'sessionrestore', 04:55:00 INFO - 'sessionrestore_no_auto_restore']}, 04:55:00 INFO - 'svgr': {'tests': ['tsvgx', 04:55:00 INFO - 'tsvgr_opacity', 04:55:00 INFO - 'tart', 04:55:00 INFO - 'tscrollx', 04:55:00 INFO - 'cart']}, 04:55:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:55:00 INFO - 'tests': ['tsvgx', 04:55:00 INFO - 'tsvgr_opacity', 04:55:00 INFO - 'tart', 04:55:00 INFO - 'tscrollx', 04:55:00 INFO - 'cart']}, 04:55:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:00 INFO - 'tests': ['tp5o']}, 04:55:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:00 INFO - 'talos_options': ['--e10s'], 04:55:00 INFO - 'tests': ['tp5o']}, 04:55:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:00 INFO - 'talos_options': ['--xperf_path', 04:55:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:00 INFO - 'tests': ['tp5n']}, 04:55:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:00 INFO - 'talos_options': ['--e10s', 04:55:00 INFO - '--xperf_path', 04:55:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:00 INFO - 'tests': ['tp5n']}}, 04:55:00 INFO - 'talos.zip': {'path': '', 04:55:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:55:00 INFO - Running post-action listener: _resource_record_post_action 04:55:00 INFO - ##### 04:55:00 INFO - ##### Running create-virtualenv step. 04:55:00 INFO - ##### 04:55:00 INFO - Running pre-action listener: _resource_record_pre_action 04:55:00 INFO - Running main action method: create_virtualenv 04:55:00 INFO - Creating virtualenv /builds/slave/test/build/venv 04:55:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:55:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:55:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:55:00 INFO - Using real prefix '/usr' 04:55:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:55:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:55:03 INFO - Installing pip.................done. 04:55:03 INFO - Return code: 0 04:55:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:03 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 0x7faa7ea23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205e3d0>, '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 0x1fc9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fca360>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:55:03 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 04:55:03 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 04:55:03 INFO - Using env: {'DISPLAY': ':0', 04:55:03 INFO - 'HOME': '/home/cltbld', 04:55:03 INFO - 'LANG': 'en_US.UTF-8', 04:55:03 INFO - 'LANGUAGE': 'en_US:en', 04:55:03 INFO - 'LOGNAME': 'cltbld', 04:55:03 INFO - 'MAIL': '/var/mail/cltbld', 04:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:03 INFO - 'MOZ_NO_REMOTE': '1', 04:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:03 INFO - 'NO_EM_RESTART': '1', 04:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:03 INFO - 'PWD': '/builds/slave/test', 04:55:03 INFO - 'SHELL': '/bin/bash', 04:55:03 INFO - 'SHLVL': '1', 04:55:03 INFO - 'TERM': 'linux', 04:55:03 INFO - 'TMOUT': '86400', 04:55:03 INFO - 'USER': 'cltbld', 04:55:03 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 04:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:03 INFO - '_': '/tools/buildbot/bin/python'} 04:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:55:03 INFO - Cleaning up... 04:55:03 INFO - Return code: 0 04:55:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:03 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 0x7faa7ea23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205e3d0>, '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 0x1fc9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fca360>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:55:03 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 04:55:03 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 04:55:03 INFO - Using env: {'DISPLAY': ':0', 04:55:03 INFO - 'HOME': '/home/cltbld', 04:55:03 INFO - 'LANG': 'en_US.UTF-8', 04:55:03 INFO - 'LANGUAGE': 'en_US:en', 04:55:03 INFO - 'LOGNAME': 'cltbld', 04:55:03 INFO - 'MAIL': '/var/mail/cltbld', 04:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:03 INFO - 'MOZ_NO_REMOTE': '1', 04:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:03 INFO - 'NO_EM_RESTART': '1', 04:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:03 INFO - 'PWD': '/builds/slave/test', 04:55:03 INFO - 'SHELL': '/bin/bash', 04:55:03 INFO - 'SHLVL': '1', 04:55:03 INFO - 'TERM': 'linux', 04:55:03 INFO - 'TMOUT': '86400', 04:55:03 INFO - 'USER': 'cltbld', 04:55:03 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 04:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:03 INFO - '_': '/tools/buildbot/bin/python'} 04:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:03 INFO - Downloading/unpacking psutil>=0.7.1 04:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:55:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:55:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:05 INFO - Installing collected packages: psutil 04:55:05 INFO - Running setup.py install for psutil 04:55:05 INFO - building 'psutil._psutil_linux' extension 04:55:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:55:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:55:05 INFO - building 'psutil._psutil_posix' extension 04:55:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:55:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:55:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:05 INFO - Successfully installed psutil 04:55:05 INFO - Cleaning up... 04:55:05 INFO - Return code: 0 04:55:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:05 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 0x7faa7ea23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205e3d0>, '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 0x1fc9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fca360>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:55:05 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 04:55:05 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 04:55:05 INFO - Using env: {'DISPLAY': ':0', 04:55:05 INFO - 'HOME': '/home/cltbld', 04:55:05 INFO - 'LANG': 'en_US.UTF-8', 04:55:05 INFO - 'LANGUAGE': 'en_US:en', 04:55:05 INFO - 'LOGNAME': 'cltbld', 04:55:05 INFO - 'MAIL': '/var/mail/cltbld', 04:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:05 INFO - 'MOZ_NO_REMOTE': '1', 04:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:05 INFO - 'NO_EM_RESTART': '1', 04:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:05 INFO - 'PWD': '/builds/slave/test', 04:55:05 INFO - 'SHELL': '/bin/bash', 04:55:05 INFO - 'SHLVL': '1', 04:55:05 INFO - 'TERM': 'linux', 04:55:05 INFO - 'TMOUT': '86400', 04:55:05 INFO - 'USER': 'cltbld', 04:55:05 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 04:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:05 INFO - '_': '/tools/buildbot/bin/python'} 04:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:55:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:55:07 INFO - Installing collected packages: mozsystemmonitor 04:55:07 INFO - Running setup.py install for mozsystemmonitor 04:55:07 INFO - Successfully installed mozsystemmonitor 04:55:07 INFO - Cleaning up... 04:55:08 INFO - Return code: 0 04:55:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:08 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 0x7faa7ea23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205e3d0>, '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 0x1fc9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fca360>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:55:08 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 04:55:08 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 04:55:08 INFO - Using env: {'DISPLAY': ':0', 04:55:08 INFO - 'HOME': '/home/cltbld', 04:55:08 INFO - 'LANG': 'en_US.UTF-8', 04:55:08 INFO - 'LANGUAGE': 'en_US:en', 04:55:08 INFO - 'LOGNAME': 'cltbld', 04:55:08 INFO - 'MAIL': '/var/mail/cltbld', 04:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:08 INFO - 'MOZ_NO_REMOTE': '1', 04:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:08 INFO - 'NO_EM_RESTART': '1', 04:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:08 INFO - 'PWD': '/builds/slave/test', 04:55:08 INFO - 'SHELL': '/bin/bash', 04:55:08 INFO - 'SHLVL': '1', 04:55:08 INFO - 'TERM': 'linux', 04:55:08 INFO - 'TMOUT': '86400', 04:55:08 INFO - 'USER': 'cltbld', 04:55:08 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 04:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:08 INFO - '_': '/tools/buildbot/bin/python'} 04:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:08 INFO - Downloading/unpacking blobuploader==1.2.4 04:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:09 INFO - Downloading blobuploader-1.2.4.tar.gz 04:55:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:55:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:55:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:10 INFO - Downloading docopt-0.6.1.tar.gz 04:55:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:55:10 INFO - Installing collected packages: blobuploader, requests, docopt 04:55:10 INFO - Running setup.py install for blobuploader 04:55:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:55:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:55:10 INFO - Running setup.py install for requests 04:55:11 INFO - Running setup.py install for docopt 04:55:11 INFO - Successfully installed blobuploader requests docopt 04:55:11 INFO - Cleaning up... 04:55:11 INFO - Return code: 0 04:55:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:11 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 0x7faa7ea23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205e3d0>, '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 0x1fc9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fca360>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:55:11 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 04:55:11 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 04:55:11 INFO - Using env: {'DISPLAY': ':0', 04:55:11 INFO - 'HOME': '/home/cltbld', 04:55:11 INFO - 'LANG': 'en_US.UTF-8', 04:55:11 INFO - 'LANGUAGE': 'en_US:en', 04:55:11 INFO - 'LOGNAME': 'cltbld', 04:55:11 INFO - 'MAIL': '/var/mail/cltbld', 04:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:11 INFO - 'MOZ_NO_REMOTE': '1', 04:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:11 INFO - 'NO_EM_RESTART': '1', 04:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:11 INFO - 'PWD': '/builds/slave/test', 04:55:11 INFO - 'SHELL': '/bin/bash', 04:55:11 INFO - 'SHLVL': '1', 04:55:11 INFO - 'TERM': 'linux', 04:55:11 INFO - 'TMOUT': '86400', 04:55:11 INFO - 'USER': 'cltbld', 04:55:11 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 04:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:11 INFO - '_': '/tools/buildbot/bin/python'} 04:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:55:11 INFO - Running setup.py (path:/tmp/pip-81qx4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:55:11 INFO - Running setup.py (path:/tmp/pip-bN0Yla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:55:11 INFO - Running setup.py (path:/tmp/pip-9JkyYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:55:11 INFO - Running setup.py (path:/tmp/pip-uDZZ0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:55:11 INFO - Running setup.py (path:/tmp/pip-8uSQHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:55:11 INFO - Running setup.py (path:/tmp/pip-t9GcFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:55:11 INFO - Running setup.py (path:/tmp/pip-7eMMWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:55:11 INFO - Running setup.py (path:/tmp/pip-V300jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:55:12 INFO - Running setup.py (path:/tmp/pip-1vMtFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:55:12 INFO - Running setup.py (path:/tmp/pip-wAeqSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:55:12 INFO - Running setup.py (path:/tmp/pip-8iOU56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:55:12 INFO - Running setup.py (path:/tmp/pip-Zlyfrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:55:12 INFO - Running setup.py (path:/tmp/pip-vAF7d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:55:12 INFO - Running setup.py (path:/tmp/pip-6bIqg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:12 INFO - Running setup.py (path:/tmp/pip-wBWsJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:55:12 INFO - Running setup.py (path:/tmp/pip-bypjUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:55:12 INFO - Running setup.py (path:/tmp/pip-7B_g_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:55:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:55:12 INFO - Running setup.py install for manifestparser 04:55:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:55:12 INFO - Running setup.py install for mozcrash 04:55:12 INFO - Running setup.py install for mozdebug 04:55:12 INFO - Running setup.py install for mozdevice 04:55:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:55:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:55:13 INFO - Running setup.py install for mozfile 04:55:13 INFO - Running setup.py install for mozhttpd 04:55:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:55:13 INFO - Running setup.py install for mozinfo 04:55:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:55:13 INFO - Running setup.py install for mozInstall 04:55:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:55:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:55:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:55:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:55:13 INFO - Running setup.py install for mozleak 04:55:13 INFO - Running setup.py install for mozlog 04:55:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:55:13 INFO - Running setup.py install for moznetwork 04:55:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:55:13 INFO - Running setup.py install for mozprocess 04:55:13 INFO - Running setup.py install for mozprofile 04:55:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:55:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:55:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:55:14 INFO - Running setup.py install for mozrunner 04:55:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:55:14 INFO - Running setup.py install for mozscreenshot 04:55:14 INFO - Running setup.py install for moztest 04:55:14 INFO - Running setup.py install for mozversion 04:55:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:55:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:55:14 INFO - Cleaning up... 04:55:14 INFO - Return code: 0 04:55:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:14 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 0x7faa7ea23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205e3d0>, '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 0x1fc9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fca360>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:55:14 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 04:55:14 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 04:55:14 INFO - Using env: {'DISPLAY': ':0', 04:55:14 INFO - 'HOME': '/home/cltbld', 04:55:14 INFO - 'LANG': 'en_US.UTF-8', 04:55:14 INFO - 'LANGUAGE': 'en_US:en', 04:55:14 INFO - 'LOGNAME': 'cltbld', 04:55:14 INFO - 'MAIL': '/var/mail/cltbld', 04:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:14 INFO - 'MOZ_NO_REMOTE': '1', 04:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:14 INFO - 'NO_EM_RESTART': '1', 04:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:14 INFO - 'PWD': '/builds/slave/test', 04:55:14 INFO - 'SHELL': '/bin/bash', 04:55:14 INFO - 'SHLVL': '1', 04:55:14 INFO - 'TERM': 'linux', 04:55:14 INFO - 'TMOUT': '86400', 04:55:14 INFO - 'USER': 'cltbld', 04:55:14 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 04:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:14 INFO - '_': '/tools/buildbot/bin/python'} 04:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:55:14 INFO - Running setup.py (path:/tmp/pip-YiEfo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:55:14 INFO - Running setup.py (path:/tmp/pip-HDhQhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:55:14 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)) 04:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:55:14 INFO - Running setup.py (path:/tmp/pip-XfDaqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:55:14 INFO - Running setup.py (path:/tmp/pip-pVBrsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:55:14 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)) 04:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:55:14 INFO - Running setup.py (path:/tmp/pip-b5bPKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:55:15 INFO - Running setup.py (path:/tmp/pip-0b6wyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:55:15 INFO - Running setup.py (path:/tmp/pip-wJ9r3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:55:15 INFO - Running setup.py (path:/tmp/pip-4W1Tbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:55:15 INFO - Running setup.py (path:/tmp/pip-kG497D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:55:15 INFO - Running setup.py (path:/tmp/pip-YzWmXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:55:15 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)) 04:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:55:15 INFO - Running setup.py (path:/tmp/pip-1RUklD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:55:15 INFO - Running setup.py (path:/tmp/pip-cXad33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:55:15 INFO - Running setup.py (path:/tmp/pip-KpVM1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:55:15 INFO - Running setup.py (path:/tmp/pip-fTfv6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:15 INFO - Running setup.py (path:/tmp/pip-HAZVDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:55:15 INFO - Running setup.py (path:/tmp/pip-fX6Cx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:55:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:55:15 INFO - Running setup.py (path:/tmp/pip-i1_bcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:55:15 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)) 04:55:15 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)) 04:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:55:15 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)) 04:55:15 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)) 04:55:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:17 INFO - Downloading blessings-1.5.1.tar.gz 04:55:17 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 04:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:55:17 INFO - Installing collected packages: blessings 04:55:17 INFO - Running setup.py install for blessings 04:55:17 INFO - Successfully installed blessings 04:55:17 INFO - Cleaning up... 04:55:17 INFO - Return code: 0 04:55:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:55:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:55:18 INFO - Reading from file tmpfile_stdout 04:55:18 INFO - Current package versions: 04:55:18 INFO - argparse == 1.2.1 04:55:18 INFO - blessings == 1.5.1 04:55:18 INFO - blobuploader == 1.2.4 04:55:18 INFO - docopt == 0.6.1 04:55:18 INFO - manifestparser == 1.1 04:55:18 INFO - mozInstall == 1.12 04:55:18 INFO - mozcrash == 0.16 04:55:18 INFO - mozdebug == 0.1 04:55:18 INFO - mozdevice == 0.47 04:55:18 INFO - mozfile == 1.2 04:55:18 INFO - mozhttpd == 0.7 04:55:18 INFO - mozinfo == 0.9 04:55:18 INFO - mozleak == 0.1 04:55:18 INFO - mozlog == 3.1 04:55:18 INFO - moznetwork == 0.27 04:55:18 INFO - mozprocess == 0.22 04:55:18 INFO - mozprofile == 0.28 04:55:18 INFO - mozrunner == 6.11 04:55:18 INFO - mozscreenshot == 0.1 04:55:18 INFO - mozsystemmonitor == 0.0 04:55:18 INFO - moztest == 0.7 04:55:18 INFO - mozversion == 1.4 04:55:18 INFO - psutil == 3.1.1 04:55:18 INFO - requests == 1.2.3 04:55:18 INFO - wsgiref == 0.1.2 04:55:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:18 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 0x7faa7ea23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205e3d0>, '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 0x1fc9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fca360>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:55:18 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 04:55:18 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 04:55:18 INFO - Using env: {'DISPLAY': ':0', 04:55:18 INFO - 'HOME': '/home/cltbld', 04:55:18 INFO - 'LANG': 'en_US.UTF-8', 04:55:18 INFO - 'LANGUAGE': 'en_US:en', 04:55:18 INFO - 'LOGNAME': 'cltbld', 04:55:18 INFO - 'MAIL': '/var/mail/cltbld', 04:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:18 INFO - 'MOZ_NO_REMOTE': '1', 04:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:18 INFO - 'NO_EM_RESTART': '1', 04:55:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:18 INFO - 'PWD': '/builds/slave/test', 04:55:18 INFO - 'SHELL': '/bin/bash', 04:55:18 INFO - 'SHLVL': '1', 04:55:18 INFO - 'TERM': 'linux', 04:55:18 INFO - 'TMOUT': '86400', 04:55:18 INFO - 'USER': 'cltbld', 04:55:18 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 04:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:18 INFO - '_': '/tools/buildbot/bin/python'} 04:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:55:18 INFO - Cleaning up... 04:55:18 INFO - Return code: 0 04:55:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:18 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 0x7faa7ea23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205e3d0>, '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 0x1fc9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fca360>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:55:18 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 04:55:18 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 04:55:18 INFO - Using env: {'DISPLAY': ':0', 04:55:18 INFO - 'HOME': '/home/cltbld', 04:55:18 INFO - 'LANG': 'en_US.UTF-8', 04:55:18 INFO - 'LANGUAGE': 'en_US:en', 04:55:18 INFO - 'LOGNAME': 'cltbld', 04:55:18 INFO - 'MAIL': '/var/mail/cltbld', 04:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:18 INFO - 'MOZ_NO_REMOTE': '1', 04:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:18 INFO - 'NO_EM_RESTART': '1', 04:55:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:18 INFO - 'PWD': '/builds/slave/test', 04:55:18 INFO - 'SHELL': '/bin/bash', 04:55:18 INFO - 'SHLVL': '1', 04:55:18 INFO - 'TERM': 'linux', 04:55:18 INFO - 'TMOUT': '86400', 04:55:18 INFO - 'USER': 'cltbld', 04:55:18 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 04:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:18 INFO - '_': '/tools/buildbot/bin/python'} 04:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:18 INFO - Downloading/unpacking jsonschema 04:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:55:20 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 04:55:20 INFO - Downloading/unpacking functools32 (from jsonschema) 04:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:20 INFO - Downloading functools32-3.2.3-2.tar.gz 04:55:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:55:20 INFO - warning: no files found matching '*.txt' 04:55:20 INFO - no previously-included directories found matching 'build' 04:55:20 INFO - no previously-included directories found matching 'dist' 04:55:20 INFO - no previously-included directories found matching '.git*' 04:55:20 INFO - Installing collected packages: jsonschema, functools32 04:55:20 INFO - Running setup.py install for functools32 04:55:20 INFO - warning: no files found matching '*.txt' 04:55:20 INFO - no previously-included directories found matching 'build' 04:55:20 INFO - no previously-included directories found matching 'dist' 04:55:20 INFO - no previously-included directories found matching '.git*' 04:55:20 INFO - Successfully installed jsonschema functools32 04:55:20 INFO - Cleaning up... 04:55:20 INFO - Return code: 0 04:55:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:20 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 0x7faa7ea23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205e3d0>, '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 0x1fc9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fca360>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:55:20 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 04:55:20 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 04:55:20 INFO - Using env: {'DISPLAY': ':0', 04:55:20 INFO - 'HOME': '/home/cltbld', 04:55:20 INFO - 'LANG': 'en_US.UTF-8', 04:55:20 INFO - 'LANGUAGE': 'en_US:en', 04:55:20 INFO - 'LOGNAME': 'cltbld', 04:55:20 INFO - 'MAIL': '/var/mail/cltbld', 04:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:20 INFO - 'MOZ_NO_REMOTE': '1', 04:55:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:20 INFO - 'NO_EM_RESTART': '1', 04:55:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:20 INFO - 'PWD': '/builds/slave/test', 04:55:20 INFO - 'SHELL': '/bin/bash', 04:55:20 INFO - 'SHLVL': '1', 04:55:20 INFO - 'TERM': 'linux', 04:55:20 INFO - 'TMOUT': '86400', 04:55:20 INFO - 'USER': 'cltbld', 04:55:20 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 04:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:20 INFO - '_': '/tools/buildbot/bin/python'} 04:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:20 INFO - Downloading/unpacking flake8 04:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:55:22 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 04:55:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:55:22 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 04:55:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:23 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 04:55:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:55:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:55:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:55:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:55:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:55:23 INFO - no previously-included directories found matching 'docs/_build' 04:55:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:55:23 INFO - Running setup.py install for pep8 04:55:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:55:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:55:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:55:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:55:23 INFO - no previously-included directories found matching 'docs/_build' 04:55:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:55:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:55:23 INFO - Cleaning up... 04:55:23 INFO - Return code: 0 04:55:23 INFO - Running post-action listener: _resource_record_post_action 04:55:23 INFO - Running post-action listener: _start_resource_monitoring 04:55:23 INFO - Starting resource monitoring. 04:55:23 INFO - ##### 04:55:23 INFO - ##### Running install step. 04:55:23 INFO - ##### 04:55:23 INFO - Running pre-action listener: _resource_record_pre_action 04:55:23 INFO - Running main action method: install 04:55:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:55:23 INFO - Reading from file tmpfile_stdout 04:55:23 INFO - Detecting whether we're running mozinstall >=1.0... 04:55:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:55:23 INFO - Reading from file tmpfile_stdout 04:55:23 INFO - Output received: 04:55:23 INFO - Usage: mozinstall [options] installer 04:55:23 INFO - Options: 04:55:23 INFO - -h, --help show this help message and exit 04:55:23 INFO - -d DEST, --destination=DEST 04:55:23 INFO - Directory to install application into. [default: 04:55:23 INFO - "/builds/slave/test"] 04:55:23 INFO - --app=APP Application being installed. [default: firefox] 04:55:23 INFO - mkdir: /builds/slave/test/build/application 04:55:23 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'] 04:55:23 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 04:55:39 INFO - Reading from file tmpfile_stdout 04:55:39 INFO - Output received: 04:55:39 INFO - /builds/slave/test/build/application/firefox/firefox 04:55:39 INFO - Running post-action listener: _resource_record_post_action 04:55:39 INFO - ##### 04:55:39 INFO - ##### Running run-tests step. 04:55:39 INFO - ##### 04:55:39 INFO - Running pre-action listener: _resource_record_pre_action 04:55:39 INFO - Running main action method: run_tests 04:55:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:55:39 INFO - Python 2.7.3 04:55:39 INFO - Return code: 0 04:55:39 INFO - grabbing minidump binary from tooltool 04:55: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')]} 04:55:39 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 0x205e3d0>, '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 0x1fc9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fca360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:55:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:55:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:55:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:55:39 INFO - Return code: 0 04:55:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:55:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:55:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:55:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:55:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:55:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:55:40 INFO - Return code: 0 04:55:40 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/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 04:55:40 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/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 04:55:40 INFO - Using env: {'DISPLAY': ':0', 04:55:40 INFO - 'HOME': '/home/cltbld', 04:55:40 INFO - 'LANG': 'en_US.UTF-8', 04:55:40 INFO - 'LANGUAGE': 'en_US:en', 04:55:40 INFO - 'LOGNAME': 'cltbld', 04:55:40 INFO - 'MAIL': '/var/mail/cltbld', 04:55:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:55:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:40 INFO - 'MOZ_NO_REMOTE': '1', 04:55:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:55:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:40 INFO - 'NO_EM_RESTART': '1', 04:55:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:40 INFO - 'PWD': '/builds/slave/test', 04:55:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:55:40 INFO - 'SHELL': '/bin/bash', 04:55:40 INFO - 'SHLVL': '1', 04:55:40 INFO - 'TERM': 'linux', 04:55:40 INFO - 'TMOUT': '86400', 04:55:40 INFO - 'USER': 'cltbld', 04:55:40 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199', 04:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:40 INFO - '_': '/tools/buildbot/bin/python'} 04:55:40 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/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 04:55:40 INFO - mozversion application_buildid: 20151221041538 04:55:40 INFO - mozversion application_changeset: 03f6b2915b9fe1a8df03f8256fd4b8235535f216 04:55:40 INFO - mozversion application_display_name: Nightly 04:55:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:55:40 INFO - mozversion application_name: Firefox 04:55:40 INFO - mozversion application_remotingname: firefox 04:55:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:55:40 INFO - mozversion application_vendor: Mozilla 04:55:40 INFO - mozversion application_version: 46.0a1 04:55:40 INFO - mozversion platform_buildid: 20151221041538 04:55:40 INFO - mozversion platform_changeset: 03f6b2915b9fe1a8df03f8256fd4b8235535f216 04:55:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:55:40 INFO - mozversion platform_version: 46.0a1 04:55:40 INFO - using testdate: 1450702540 04:55:40 INFO - actual date: 1450702540 04:55:40 INFO - starting webserver on 'localhost:35281' 04:55:40 INFO - SUITE-START | Running 3 tests 04:55:40 INFO - TEST-START | dromaeo_css 04:55:40 INFO - operating with platform_type : linux_ 04:55:40 INFO - Initialising browser for dromaeo_css test... 04:55:40 INFO - TEST-INFO | started process 20406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTyD7e7/profile http://localhost:35281/getInfo.html) 04:55:44 INFO - PROCESS | 20406 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:55:44 INFO - PROCESS | 20406 | __metrics Screen width/height:1600/1200 04:55:44 INFO - PROCESS | 20406 | colorDepth:24 04:55:44 INFO - PROCESS | 20406 | Browser inner width/height: 1024/697 04:55:44 INFO - PROCESS | 20406 | __metrics 04:55:44 INFO - PROCESS | 20406 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:55:44 INFO - PROCESS | 20406 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:55:46 INFO - TEST-INFO | 20406: exit 0 04:55:46 INFO - Browser initialized. 04:55:46 INFO - Running cycle 1/1 for dromaeo_css test... 04:55:46 INFO - TEST-INFO | started process 20498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTyD7e7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:57 INFO - PROCESS | 20498 | RSS: Main: 149807104 04:55:57 INFO - PROCESS | 20498 | 04:56:49 INFO - PROCESS | 20498 | 1450702609130 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:59:00 INFO - PROCESS | 20498 | Cycle 1(1): loaded http://localhost:35281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35281/tests/dromaeo/cssquery-ext.html) 04:59:01 INFO - PROCESS | 20498 | RSS: Main: 256204800 04:59:01 INFO - PROCESS | 20498 | 05:02:04 INFO - PROCESS | 20498 | Cycle 1(1): loaded http://localhost:35281/tests/dromaeo/cssquery-ext.html (next: http://localhost:35281/tests/dromaeo/cssquery-jquery.html) 05:02:04 INFO - PROCESS | 20498 | RSS: Main: 224186368 05:02:04 INFO - PROCESS | 20498 | 05:05:06 INFO - PROCESS | 20498 | Cycle 1(1): loaded http://localhost:35281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35281/tests/dromaeo/cssquery-mootools.html) 05:05:07 INFO - PROCESS | 20498 | RSS: Main: 227835904 05:05:07 INFO - PROCESS | 20498 | 05:08:09 INFO - PROCESS | 20498 | Cycle 1(1): loaded http://localhost:35281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35281/tests/dromaeo/cssquery-prototype.html) 05:08:10 INFO - PROCESS | 20498 | RSS: Main: 213745664 05:08:10 INFO - PROCESS | 20498 | 05:11:12 INFO - PROCESS | 20498 | Cycle 1(1): loaded http://localhost:35281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35281/tests/dromaeo/cssquery-yui.html) 05:11:13 INFO - PROCESS | 20498 | RSS: Main: 215162880 05:11:13 INFO - PROCESS | 20498 | 05:14:15 INFO - PROCESS | 20498 | Cycle 1(1): loaded http://localhost:35281/tests/dromaeo/cssquery-yui.html (next: http://localhost:35281/tests/dromaeo/cssquery-dojo.html) 05:14:16 INFO - PROCESS | 20498 | RSS: Main: 257536000 05:14:16 INFO - PROCESS | 20498 | 05:14:16 INFO - PROCESS | 20498 | __start_tp_report 05:14:16 INFO - PROCESS | 20498 | _x_x_mozilla_page_load 05:14:16 INFO - PROCESS | 20498 | _x_x_mozilla_page_load_details 05:14:16 INFO - PROCESS | 20498 | |i|pagename|runs| 05:14:16 INFO - PROCESS | 20498 | |0;dojo.html;2553.9106131285403;2636.7626913577774;2645.96031059534;2665.746754058365;2666.49336626041;4256.723312984662;4418.160549495594;4522.706024108435;4531.45622525297;4532.4334458192725;4436.600705936473;4446.133004064209;4535.3877226574405;4582.931256031162;4587.24310488769;4017.5178978522617;4096.549379568245;4128.75227486351;4252.936205956913;4288.099499105176;4237.449131612886;4302.827886884521;4304.892377690551;4307.913841723163;4329;4008.559058503577;4055.026793569522;4109.3425051991835;4125.876223713293;4139.503259608836;4169.749815011079;4194.580541945811;4217.472815898012;4229.6404805591565;4248.044190057243;3999;4179.665626749853;4188.204241194163;4196.412502249687;4221.155768846213;4337.934930976038;4398.142362239365;4434.357018232338;4439.955600443986;4466.731996080245;4825.951740482586;4832.589229915461;4855.975720121377;4861.659683822134;4901.926471102936;4669.299605059235;4879.4388645305535;4883.096627123993;4885.169521181372;4935.35840340757;4398.274284743045;4478.798454069574;4489.102179564067;4509.075639493896;4517.548245175456;4896.36347274852;4988.575971042502;4990.875228119254;4992.850214493571;5035.345405097314;4521.683482156283;4767.95232047682;4798.088363210979;4800.927986080212;4833.202521583969;4703.294505824086;4785.234362501983;4785.784639691222;4790.377250957354;4795.184818580849;4789.353437285922;4805.063012712488;4806.110869489155;4807.975960120177;4810.037992401533;4785.186518291899;4791.5687588117235;4793.1372352976105;4793.616510679138;4825.445073816556;3906.277338692351;4016.136530645925;4019.0756126090578;4028.7582745035393;4061.898452538651;3475.721942244614;3520.119970007498;3535.681788639035;3555.964440355615;3571.375009373401;4195.391668208093;4197.412362269285;4209.968557703382;4218.578142185757;4242.53332133465;4660.603848672833;4780.020095880336;4780.306855505932;4798.47216806151;4852.975735121302;4127.153933443637;4185.24665560196;4194.454720886326;4226.197022565702;4234.851780187741;4240.957590424056;4280.336547835091;4286.485621725413;4287.485501739811;4321.2005778931;4421.226285399978;4521.36700861873;4529.932051019171;4578.848284049504;4632.189366860854;4680.672352935398;4780.95219047805;4795.376601041842;4801.351817504592;4831.9275210871165;4581.679282450196;4649.628029757679;4666;4670.626349892068;4702.717836929795;4669.953300466952;4790.760461976817;4796.712197268175;4816.638752093677;4825.203841366276;4693.225617773166;4742.312364707029;4764.8332308369045;4771.379720636295;4805.231163013901;4690.601298889496;4755.904881902412;4770.403699537558;4773.284007398918;4813.95186048149;4515.706479078849;4619.122366750306;4621.537846215351;4750.572448479654;4765.999140180601;4420.53584373649;4467.15124126415;4479.910401792011;4515.593596576324;4522.253828118323;4686.976565117153;4736.73947932867;4738.289256611398;4742.952570474389;4748.833790817304;4390.165868484977;4482.529334419839;4492.2587773017085;4610.561996610317;4634.629229661687 05:14:16 INFO - PROCESS | 20498 | |1;ext.html;513.8766695992962;514.9382074151102;520.7838746920029;530.625908734342;541.9647722898014;26032.088876889313;35112.29775404491;35662.64337356626;35715.464268036;35829.46255806158;39720.80139599298;40240.597594024126;40313.59686403135;40313.59686403135;40341.39487907684;7015.2984701529695;7118.0390647262475;7984.560849153294;8153.510789352628;8165.2243036911395;10087.596496140182;10342.948285258562;10438.373697578132;10460.581576736922;10466.110380617656;10166.288359814778;10281.383117012965;10283.074523292902;10285.485725713721;10291.073803357696;7139.178994415631;7292.19785823559;10019.849702254473;10025.749356266078;10250.589976400935;9936.105750482418;10053.949730251303;10055.245856560787;10056.497175141214;10060.69817905464;37109.62890371089;37676.43485347722;37695.62304376976;37716.62283377159;37751.622483775085;2853.1725799518113;2902.6226590543306;3008.9849550752106;3401.693847553707;3484.4947482615135;28156;28409.71590284112;28443.431131377256;28731.138065858057;29083;3254.6908043735807;3266.5590145330552;3320.634730179678;3327.317899830529;3375.5611770469927;215410;217206.99999999843;217396;217519;217863;51388.48611513837;52938.47061529335;61925;63157.36842631607;63284.683576581825;55235;55266.44733552694;55550.44449555533;55571.44428555744;55665;12988;13098.410571524304;13150.934245328712;13184.73630527384;13184.802227966587;9566.091221333962;9571.37786043905;9622.422654640744;9630.374025688308;9638.614455421844;19472.80527194738;19668.803311966698;19708.901455492916;19720.605587888447;19785.901070494845;7800.492967957065;7865.685372585032;7944.6822127114265;7979.5611241382285;7999.880001799977;917.5916717060844;942.8020115775627;943.9056094390506;976.7753416714196;1007.1087087927237;23869.283247705178;23995.880020599787;24119.517609647708;24145.637815432783;24957.50722253343;967.5549247346158;979.5004547680734;1000.46475135802;1033.0083120204538;1082.7130810335268;13921.443142274398;13947.648987156357;14036.087654302437;14071.859281407054;14288.214148221947;259308;263948;264006;264206.14763114275;264516;44978.10043799106;45146.54853451424;45433;45484.77257613691;45573.5442645576;1198.6344165029575;1203.3080978437433;1215.1979693402488;1215.5563219424846;1216.0636310041396;24736;25555.233342999738;26046.869765651052;26248.212553623423;26360.604590931536;40487.392689110275;40742;40907.59092409038;40953.79523102365;41035.7948210257;237481;238945;238964;292185;304141;27408.862955685094;27486;27520;27627.171184864485;27876.30309242285;35194;39448.2110357797;39550.60449395469;39840.40239396354;40244.1951160981;29927.401451970403;30138.54792178163;30353.392932141676;38004.429933551575;39916.60083399129;31501.842490788316;33376.33247334991;33494.49758253579;33551.664483354856;33608;32888.50667239945;33120.17199569933;33203.667963320055;37715.62284377231;38456.80771596236;29229.85385073061;30192;30501;30737.231569210948;30779.692203077684;23642.52714945726;23719.288421347388;23800.642990355504;24037.278881633578;24136.396590085387 05:14:16 INFO - PROCESS | 20498 | |2;jquery.html;294.4405629304322;303.9392121575687;305.17298122089136;309.1020585199994;316.13064073797057;12643.620691379274;13059.934700326485;15281.541553753392;15400.152991585472;15777.605559860995;15273.923630381832;15599.220038998033;15911.522654320388;15922.203889805522;15936.282867270971;4889.608831293505;6233.3143354231;6435.806925792233;6442.935570644304;6446.774362897299;4067.32889073304;4227.175700738358;6355.68221588921;6369.93630063698;6684.29814869439;6391.744330226786;6662.034005069262;6666.366695163976;6667.799966001027;6704.396604305612;6689.732410703566;6718.294579069225;6724.260331363571;6727.159105111837;6731.93268067318;6253.405926436982;6422.068800024017;6424.196975378078;6426.710798014101;6433.45597056703;21085.5782884343;21093.47266318339;21551.67672484914;21676;21795.455113622127;1903.980960190408;1964.7544056992876;1974.131382191831;2069.193014724259;2092.665173572221;13344;13349;13388.799168012487;13599.728005439836;13947.860521394758;1751.448293787453;1823.0429024761972;1826.5159732670852;1867.1317837205765;1873.3724202392216;60345.698271508365;64102.358976410105;64559;64719;64946.3505364945;15479.613009674624;15522.37910483568;15551.14468704232;15562.533124006071;15681.764773528406;23432.88283558571;23440.187177538806;23786.88106559456;23833.880830595735;23844.64233036506;8552.401331906707;8624.78438039054;8652.307815374756;8731.083236260229;8737.650493980169;7292.525985810906;7322;7324.853502929912;7351.8162045949275;7378.815529611803;6632.602043877383;7567.621618919032;7720.266574675396;7854.8429031419055;7862.764117076496;2507.6614657021432;2946.425447037807;2976.985115074454;2980.6125203723377;2985.7014298570402;751.6054071612447;793.123598423745;826.5454000299811;857.8884744983237;919.4667093085994;15462.536123916301;15860.603484912739;15955.441559545361;16170.514884553482;16225.594360140854;851.5231470376609;871.2246100970142;913.9497327647043;915.7390143809116;938.1462868789505;8967.237784788236;8988.10118988109;9100.317476189311;9129.726108216764;9231.522956326955;419344;424678;429295;429663;429792.31869131303;61839;63479.74763280744;72565;75089.62455187799;76412.61793690996;1007.1388962437157;1022.1209759606733;1028.2493779540828;1036.7084506691226;1040.9115225205942;13756.86243137596;14324.713505730035;14366.425342986164;14375.353109110325;14483.986120971853;32805.34389312248;33387.33225335431;33712.49431258582;34869.651303487655;34928.30143397169;41140.58859411367;41161.38257926074;41735.7913210432;42084.1583168341;42254.366184506645;8368.41421100517;8672.826543469222;8761.649534018568;8765.517896515752;8767.035626080999;10085;10313.535890884777;15439.150846703089;15850.128242946748;15861.365545378518;13010.089293749346;13279.136856104322;13533.932330338286;13710.588682339545;13923.094998825043;13111.529463190245;13862.93068534651;14043.227622480861;14229;14533.34599942984;13699.315034248448;14079.859201407855;14250.073745206528;14449.205293708947;14503.78244326357;8116.594170291343;8349.165083491846;8512.40413171072;8517.48895066298;8783;12837.807432888701;12974.80537791915;13123.146995445266;13232.603021909357;13507.932460337635 05:14:16 INFO - PROCESS | 20498 | |3;mootools.html;1435.2895316818176;1637.181409295352;1686.586786237372;1712.0498123541438;1747.5893165106197;6143.846403839906;6993.405560527355;7120.893186602192;7121.465890058241;7130.500864939457;7124.109486314211;7299.927000729991;7300.634968251579;7315.305046020633;7319.9268007319915;1717.1414292853574;1745.6421433606145;1996.6905129704846;2074.3776866939897;2109.177420805887;2081.3235698398007;2093.037202886674;2099.1078791513623;2100.2544096845627;2100.6008858316945;2024.1093918675735;2024.180207016161;2063.2366024570856;2066.5350296183387;2066.8449866260016;2033.593281343737;2051.364077136078;2085.906134223956;2114.8202402795782;2119.4277545062746;2125.415510734545;2137.1771867830844;2152.397328747953;2152.6017686728005;2158.8057074863336;7191.676374563157;7280.2719728027305;7290.161631412402;7292;7298.817529561803;4089.815958281855;4135.0902801383645;4162.250794856925;4169.061961058768;4231.61915427613;2569.0622922633106;2605.1793684989166;2613.085420102968;2621.2005338371787;2624.4357463145516;795.9801004974864;798.7923139983646;801.8837268596021;816.9183081691842;824.9175082491763;9470.526473676358;9476;9478.573464194058;9493.857592136124;9497.050294970448;3859.9421008684894;3860.0735823402742;3884.223155368881;3886.436466712311;3943.7830919299713;8290.958545207235;8300.916990830136;8304.211099945496;8316.293115085164;8318.459300145592;4173.770442625624;4196.664266858644;4201.432806571135;4211.410402543646;4215.135897141079;3814.0464883779055;3816;3819.961800382016;3822.694184465236;3827.196288779332;3099.969000309968;3165.6042994625673;3302.620198677183;3430.519727238189;3431.073610125302;1046.2205656785743;1051.1590727418188;1053.210092430677;1053.8028211179624;1062.6811956413046;857.3741168946704;866.5883705240086;870.216804875617;875.4003507597316;1109.4341885638382;6846.041554182419;6877.828054298682;6888.655567221619;6918.757843475454;6927.93072069283;1047.2983101322131;1063.8510608514814;1081.8323159910226;1091.879893211746;1094.6661268313242;5280.9207861882105;5302.072137376021;5314.556895699891;5348.438413966555;5355.571554275649;8582.613782379807;8777.561121943878;8855.64577416909;8863.379563430626;8882.955585222033;8561.315094792402;8618.052014278424;8747.868781968276;8751.693690720795;8756.693515726918;6805.897911531331;6879.174499060145;6919.065926099912;6924.826879327957;6928.584284942919;6282.748690052529;6374.808755737336;6379.298277189599;6632.668366581555;6656.7670131545165;7568.659410326439;7709.614519273901;7721.112072111779;7773.3004029637605;7813;7839.725609603636;7865.3314468268545;8031.638576263966;8049.4767840092545;8095.150009248944;6474.611523308428;6552.148220731275;6560.048792925095;6565.704543295658;6575.243846957661;5877.970610147093;5957.225560677084;6697.832554186184;6865.382115609619;7119.786406407816;6409.615423074631;6526.477881769542;6547.345265473415;6635.303293154149;6647.933520664925;6369.235691717024;6404.359564043559;6412.198475190601;6539.476841852736;6589.7364105435245;6562.081308616702;6567.9671601641685;6568.934310657023;6573.276939536551;6580.078788969452;6072.787452439144;6086.6348019119;6119.265688117454;6148.1699970503405;6149.938500614937;6080.878382432238;6090.725917333642;6177.505799535937;6183.196184495987;6187.907181392373 05:14:16 INFO - PROCESS | 20498 | |4;prototype.html;283.3709165652252;291.1106569430389;293.6344251406999;297.3710602076606;302.0349981808124;5296.285001524798;5332.360116785986;5350.384705758839;5365.919511207335;5387.676739395639;5257.211418287259;5266.8419947401635;5269.683818970864;5280.815171468999;5287.206918962158;4117.464729585165;4118.361653943643;4120.629143377096;4122.051928056549;4126.844483544597;3870.632289932452;3966.2464131814863;3991.5609282978994;4055.655269302113;4063.2686116499017;4019.31671615826;4041.979790101045;4084.0810817566107;4093.0585965228015;4098.303288440958;3818.3127037133304;3908.5309762828642;4084.0810817565957;4089.4683691119963;4094.5905409459115;3501.3872572299747;3567.2687099144873;3570.357335679577;3576.409892367756;3585.2470981094;5049.141645920203;5053.36832895888;5057.2666963290485;5064.417591976933;5069.518395752398;4672.6261899047995;4673.439187297512;4673.696209746389;4685.5314468553215;4700.858974230779;5391.919121213185;5464.590155738336;5515.972420137914;5542.501174894279;5550.833474995757;3859.6526312632;3861.691064714816;3862.6909847212437;3869.0520822398694;3870.5161854768153;5841.153032810261;5843.181954526327;5849.356570777211;5860.443257890493;5863.003289440848;3973.1854969731135;3974.3839704845795;3975.185087057146;3977.343738283209;3984.2230765001127;3727.2731817295366;4043.8989025274013;4043.9687879590515;4044.2315959967514;4047.0287131088326;4320.848770293088;4425.446819147606;4482.574155455227;4527.637788976874;4659.440867095903;5487.862803429866;5558.138488534284;5566.944330556643;5571.247881536022;5572.665640061609;1382.5299398204659;1423.4733148735033;1425.6792221750022;1425.7291114688176;1425.836028856674;953.8378475659155;958.4872093430121;959.5010594490826;985.3545927417409;987.1362557761959;4904.730239836843;4908.754562271872;4914.311996320518;4914.8771280718265;4924.4090709115135;5760.36635970043;5761.251037365116;5768.826935191951;5773.076307790733;5776.249087618583;4867;4898.436679781871;4902.1176188285735;4905.901881962341;4911.214205727138;3029.712177343149;3066.141480385451;3103.379324135182;3106.689331066875;3108.5492603572357;5483.150111732688;5483.533899618497;5485.9725701371235;5490;5493.450654934474;5896.616719913192;5942.821715348547;5945.256842894638;5948.85127871798;5950.285965684146;5470.288862447856;5470.617056806065;5474.863128421821;5478.315210598676;5484.204790305464;5626.718664066699;5765.769369225184;5774.220480235283;5778.335491418541;5778.451047150514;5670;5672.014794821779;5678.14827775837;5681.062624667049;5684.602077854511;5478.233047373451;5491.725413729378;5492.505674489315;5493.450654934474;5494.80768173112;3914.412838074312;3996.1608062306077;3999.280129576704;4005.35914253718;4005.8197381118503;5521;5662.85842853932;5761.02062649359;5773.884522309446;5778.653280803165;5482.451754824486;5591.412901645269;5606.915896261477;5609.943900560942;5612.102063669793;5586.972065139648;5597.412271711411;5600.85997850057;5602.607817452739;5613.57898157648;5380.166074258496;5469;5486.423925487767;5488.588355873405;5490.368607610176;5631.099024156116;5640.0693885508435;5640.830775076754;5644.9435505644415;5647.915281270702;5461.808836690697;5461.9453805461435;5462.617616766788;5462.6995515247045;5463.207834864002 05:14:16 INFO - PROCESS | 20498 | |5;yui.html;672.0591172358701;721.7113154738104;771.3983093187314;787.8148635070761;807.1484583764127;11582.884171158286;11628.534858605657;11636.767264654713;11744.119191060683;11806.940965295184;11484.483198256077;11552.537898484072;11563.65309040728;11575.768484630302;11576.652700419001;617.253123720299;628.6699482771559;629.8740251949605;784.8351846112323;809.7327881798992;799.3085980626774;800.3597122302135;805.4522924411398;806.5644551941945;806.8265322955564;842.6839935024366;847.995760021199;848.7368915636173;848.9023762267326;848.9405741598091;649.3344322069869;656.4879394072631;830.0827585517976;844.0040751912802;844.0673056272852;631.4380201620561;631.7409861956621;631.9115323854664;632.1844820182006;632.8006677896448;11101.888981110167;11243.381614011227;11254.662360129209;11273.943630281878;11282;10965.50655220517;11609.303441793434;11650.533978640844;11721.23811952229;11905;9217.815643687089;9293.303002274857;9309.255259579286;9324.254059675277;9376.156145946898;3170.1282147409415;3222.6616205298574;3263.167892187477;3277.918052048694;3294.2423242654086;39096.413553796716;39368.409473857915;39467;39508.45652749913;39714.20571588581;9053.185213330831;9199.126083022102;9228.077192280718;9286.628534858664;9291.814163716688;17186.054766987934;17215.311387544607;17220.483385498454;17227;17228;6361.5546911716665;6559.409653131241;6587.571807832475;6608.966955165193;6850.897236541456;3443.810590417551;3510.894673159758;3517.9296414071573;3518.3139287838626;3520.4895290183294;2522.848629082261;2565.538203123456;2568.6403903453534;2574.4593635336414;2579.8065145113815;464.4565857946211;466.31218952045464;470.64231184299496;492.9309896614477;497.855621869661;417.2031419987809;526.139761489959;531.9998403002331;532.2521856791215;548.9835304940858;7251.7099316027825;7400.555966642019;7429.962850185714;7549.9245007549225;7609.733659321897;410.6263300396625;528.1760453692252;533.9172428273624;557.150345722776;563;3468.514407982884;3581.5702115746276;3588.820558972041;3598.5142005829402;3668.486411902336;47331.290030649565;47810.521894781305;47941.5205847937;47969.28046079312;48276.5172348272;44218.33672494915;45276.09447811025;45280.3207951881;46052;46381;40618.79690601528;40958.79520602438;41401.1719765603;41578.79210603928;41829.37255941163;7019.894701579378;7402.592857392895;7791.961040194763;7792.103908050647;7974.561399123104;30910.29076510743;31123.84438077795;31215.219619509695;31298.843505782326;31373.52939705952;39050;40371.59628403796;40479.19041619092;40672.38991415072;40870.1825963485;9381.390209636626;9539.856902146335;9584.993575674733;9589.856152157863;9945.751356216153;11043;11104.61133860311;11213.327200368005;11269.436528173395;11517.424128793695;10017.69946901594;10305.639302624371;10469.68590942273;10482.056614904695;10545.789084218119;10101.646442374482;10210.081092701395;10346.27576069698;10588.788224235626;10825.296355736851;10165.54255058539;10217;10337.534810933677;10579.576816927236;10606.46967651599;7899.210078992055;8163.346932245525;8336.83326333482;8393.874091888505;8699.43453675509;8323.725848771539;8414.95792521058;8578.356623253156;8699.521526316114;8704.26013788835 05:14:16 INFO - PROCESS | 20498 | __end_tp_report 05:14:16 INFO - PROCESS | 20498 | __start_cc_report 05:14:16 INFO - PROCESS | 20498 | _x_x_mozilla_cycle_collect,852 05:14:16 INFO - PROCESS | 20498 | __end_cc_report 05:14:16 INFO - PROCESS | 20498 | __startTimestamp1450703656222__endTimestamp 05:14:16 INFO - PROCESS | 20498 | 05:14:16 INFO - PROCESS | 20498 | ------- Summary: start ------- 05:14:16 INFO - PROCESS | 20498 | Number of tests: 6 05:14:16 INFO - PROCESS | 20498 | 05:14:16 INFO - PROCESS | 20498 | [#0] dojo.html Cycles:165 Average:4450.54 Median:4529.93 stddev:452.66 (10.0%) stddev-sans-first:428.89 05:14:16 INFO - PROCESS | 20498 | Values: 2553.9 2636.8 2646.0 2665.7 2666.5 4256.7 4418.2 4522.7 4531.5 4532.4 4436.6 4446.1 4535.4 4582.9 4587.2 4017.5 4096.5 4128.8 4252.9 4288.1 4237.4 4302.8 4304.9 4307.9 4329.0 4008.6 4055.0 4109.3 4125.9 4139.5 4169.7 4194.6 4217.5 4229.6 4248.0 3999.0 4179.7 4188.2 4196.4 4221.2 4337.9 4398.1 4434.4 4440.0 4466.7 4826.0 4832.6 4856.0 4861.7 4901.9 4669.3 4879.4 4883.1 4885.2 4935.4 4398.3 4478.8 4489.1 4509.1 4517.5 4896.4 4988.6 4990.9 4992.9 5035.3 4521.7 4768.0 4798.1 4800.9 4833.2 4703.3 4785.2 4785.8 4790.4 4795.2 4789.4 4805.1 4806.1 4808.0 4810.0 4785.2 4791.6 4793.1 4793.6 4825.4 3906.3 4016.1 4019.1 4028.8 4061.9 3475.7 3520.1 3535.7 3556.0 3571.4 4195.4 4197.4 4210.0 4218.6 4242.5 4660.6 4780.0 4780.3 4798.5 4853.0 4127.2 4185.2 4194.5 4226.2 4234.9 4241.0 4280.3 4286.5 4287.5 4321.2 4421.2 4521.4 4529.9 4578.8 4632.2 4680.7 4781.0 4795.4 4801.4 4831.9 4581.7 4649.6 4666.0 4670.6 4702.7 4670.0 4790.8 4796.7 4816.6 4825.2 4693.2 4742.3 4764.8 4771.4 4805.2 4690.6 4755.9 4770.4 4773.3 4814.0 4515.7 4619.1 4621.5 4750.6 4766.0 4420.5 4467.2 4479.9 4515.6 4522.3 4687.0 4736.7 4738.3 4743.0 4748.8 4390.2 4482.5 4492.3 4610.6 4634.6 05:14:16 INFO - PROCESS | 20498 | 05:14:16 INFO - PROCESS | 20498 | [#1] ext.html Cycles:180 Average:41028.53 Median:30619.12 stddev:64865.03 (211.8%) stddev-sans-first:64975.66 05:14:16 INFO - PROCESS | 20498 | Values: 513.9 514.9 520.8 530.6 542.0 26032.1 35112.3 35662.6 35715.5 35829.5 39720.8 40240.6 40313.6 40313.6 40341.4 7015.3 7118.0 7984.6 8153.5 8165.2 10087.6 10342.9 10438.4 10460.6 10466.1 10166.3 10281.4 10283.1 10285.5 10291.1 7139.2 7292.2 10019.8 10025.7 10250.6 9936.1 10053.9 10055.2 10056.5 10060.7 37109.6 37676.4 37695.6 37716.6 37751.6 2853.2 2902.6 3009.0 3401.7 3484.5 28156.0 28409.7 28443.4 28731.1 29083.0 3254.7 3266.6 3320.6 3327.3 3375.6 215410.0 217207.0 217396.0 217519.0 217863.0 51388.5 52938.5 61925.0 63157.4 63284.7 55235.0 55266.4 55550.4 55571.4 55665.0 12988.0 13098.4 13150.9 13184.7 13184.8 9566.1 9571.4 9622.4 9630.4 9638.6 19472.8 19668.8 19708.9 19720.6 19785.9 7800.5 7865.7 7944.7 7979.6 7999.9 917.6 942.8 943.9 976.8 1007.1 23869.3 23995.9 24119.5 24145.6 24957.5 967.6 979.5 1000.5 1033.0 1082.7 13921.4 13947.6 14036.1 14071.9 14288.2 259308.0 263948.0 264006.0 264206.1 264516.0 44978.1 45146.5 45433.0 45484.8 45573.5 1198.6 1203.3 1215.2 1215.6 1216.1 24736.0 25555.2 26046.9 26248.2 26360.6 40487.4 40742.0 40907.6 40953.8 41035.8 237481.0 238945.0 238964.0 292185.0 304141.0 27408.9 27486.0 27520.0 27627.2 27876.3 35194.0 39448.2 39550.6 39840.4 40244.2 29927.4 30138.5 30353.4 38004.4 39916.6 31501.8 33376.3 33494.5 33551.7 33608.0 32888.5 33120.2 33203.7 37715.6 38456.8 29229.9 30192.0 30501.0 30737.2 30779.7 23642.5 23719.3 23800.6 24037.3 24136.4 05:14:16 INFO - PROCESS | 20498 | 05:14:16 INFO - PROCESS | 20498 | [#2] jquery.html Cycles:180 Average:25818.84 Median:33096.34 stddev:69671.02 (210.5%) stddev-sans-first:69840.11 05:14:16 INFO - PROCESS | 20498 | Values: 294.4 303.9 305.2 309.1 316.1 12643.6 13059.9 15281.5 15400.2 15777.6 15273.9 15599.2 15911.5 15922.2 15936.3 4889.6 6233.3 6435.8 6442.9 6446.8 4067.3 4227.2 6355.7 6369.9 6684.3 6391.7 6662.0 6666.4 6667.8 6704.4 6689.7 6718.3 6724.3 6727.2 6731.9 6253.4 6422.1 6424.2 6426.7 6433.5 21085.6 21093.5 21551.7 21676.0 21795.5 1904.0 1964.8 1974.1 2069.2 2092.7 13344.0 13349.0 13388.8 13599.7 13947.9 1751.4 1823.0 1826.5 1867.1 1873.4 60345.7 64102.4 64559.0 64719.0 64946.4 15479.6 15522.4 15551.1 15562.5 15681.8 23432.9 23440.2 23786.9 23833.9 23844.6 8552.4 8624.8 8652.3 8731.1 8737.7 7292.5 7322.0 7324.9 7351.8 7378.8 6632.6 7567.6 7720.3 7854.8 7862.8 2507.7 2946.4 2977.0 2980.6 2985.7 751.6 793.1 826.5 857.9 919.5 15462.5 15860.6 15955.4 16170.5 16225.6 851.5 871.2 913.9 915.7 938.1 8967.2 8988.1 9100.3 9129.7 9231.5 419344.0 424678.0 429295.0 429663.0 429792.3 61839.0 63479.7 72565.0 75089.6 76412.6 1007.1 1022.1 1028.2 1036.7 1040.9 13756.9 14324.7 14366.4 14375.4 14484.0 32805.3 33387.3 33712.5 34869.7 34928.3 41140.6 41161.4 41735.8 42084.2 42254.4 8368.4 8672.8 8761.6 8765.5 8767.0 10085.0 10313.5 15439.2 15850.1 15861.4 13010.1 13279.1 13533.9 13710.6 13923.1 13111.5 13862.9 14043.2 14229.0 14533.3 13699.3 14079.9 14250.1 14449.2 14503.8 8116.6 8349.2 8512.4 8517.5 8783.0 12837.8 12974.8 13123.1 13232.6 13507.9 05:14:16 INFO - PROCESS | 20498 | 05:14:16 INFO - PROCESS | 20498 | [#3] mootools.html Cycles:180 Average:5017.31 Median:6372.02 stddev:2620.04 (41.1%) stddev-sans-first:2613.55 05:14:16 INFO - PROCESS | 20498 | Values: 1435.3 1637.2 1686.6 1712.0 1747.6 6143.8 6993.4 7120.9 7121.5 7130.5 7124.1 7299.9 7300.6 7315.3 7319.9 1717.1 1745.6 1996.7 2074.4 2109.2 2081.3 2093.0 2099.1 2100.3 2100.6 2024.1 2024.2 2063.2 2066.5 2066.8 2033.6 2051.4 2085.9 2114.8 2119.4 2125.4 2137.2 2152.4 2152.6 2158.8 7191.7 7280.3 7290.2 7292.0 7298.8 4089.8 4135.1 4162.3 4169.1 4231.6 2569.1 2605.2 2613.1 2621.2 2624.4 796.0 798.8 801.9 816.9 824.9 9470.5 9476.0 9478.6 9493.9 9497.1 3859.9 3860.1 3884.2 3886.4 3943.8 8291.0 8300.9 8304.2 8316.3 8318.5 4173.8 4196.7 4201.4 4211.4 4215.1 3814.0 3816.0 3820.0 3822.7 3827.2 3100.0 3165.6 3302.6 3430.5 3431.1 1046.2 1051.2 1053.2 1053.8 1062.7 857.4 866.6 870.2 875.4 1109.4 6846.0 6877.8 6888.7 6918.8 6927.9 1047.3 1063.9 1081.8 1091.9 1094.7 5280.9 5302.1 5314.6 5348.4 5355.6 8582.6 8777.6 8855.6 8863.4 8883.0 8561.3 8618.1 8747.9 8751.7 8756.7 6805.9 6879.2 6919.1 6924.8 6928.6 6282.7 6374.8 6379.3 6632.7 6656.8 7568.7 7709.6 7721.1 7773.3 7813.0 7839.7 7865.3 8031.6 8049.5 8095.2 6474.6 6552.1 6560.0 6565.7 6575.2 5878.0 5957.2 6697.8 6865.4 7119.8 6409.6 6526.5 6547.3 6635.3 6647.9 6369.2 6404.4 6412.2 6539.5 6589.7 6562.1 6568.0 6568.9 6573.3 6580.1 6072.8 6086.6 6119.3 6148.2 6149.9 6080.9 6090.7 6177.5 6183.2 6187.9 05:14:16 INFO - PROCESS | 20498 | 05:14:16 INFO - PROCESS | 20498 | [#4] prototype.html Cycles:180 Average:4607.80 Median:5314.32 stddev:1364.61 (25.7%) stddev-sans-first:1329.28 05:14:16 INFO - PROCESS | 20498 | Values: 283.4 291.1 293.6 297.4 302.0 5296.3 5332.4 5350.4 5365.9 5387.7 5257.2 5266.8 5269.7 5280.8 5287.2 4117.5 4118.4 4120.6 4122.1 4126.8 3870.6 3966.2 3991.6 4055.7 4063.3 4019.3 4042.0 4084.1 4093.1 4098.3 3818.3 3908.5 4084.1 4089.5 4094.6 3501.4 3567.3 3570.4 3576.4 3585.2 5049.1 5053.4 5057.3 5064.4 5069.5 4672.6 4673.4 4673.7 4685.5 4700.9 5391.9 5464.6 5516.0 5542.5 5550.8 3859.7 3861.7 3862.7 3869.1 3870.5 5841.2 5843.2 5849.4 5860.4 5863.0 3973.2 3974.4 3975.2 3977.3 3984.2 3727.3 4043.9 4044.0 4044.2 4047.0 4320.8 4425.4 4482.6 4527.6 4659.4 5487.9 5558.1 5566.9 5571.2 5572.7 1382.5 1423.5 1425.7 1425.7 1425.8 953.8 958.5 959.5 985.4 987.1 4904.7 4908.8 4914.3 4914.9 4924.4 5760.4 5761.3 5768.8 5773.1 5776.2 4867.0 4898.4 4902.1 4905.9 4911.2 3029.7 3066.1 3103.4 3106.7 3108.5 5483.2 5483.5 5486.0 5490.0 5493.5 5896.6 5942.8 5945.3 5948.9 5950.3 5470.3 5470.6 5474.9 5478.3 5484.2 5626.7 5765.8 5774.2 5778.3 5778.5 5670.0 5672.0 5678.1 5681.1 5684.6 5478.2 5491.7 5492.5 5493.5 5494.8 3914.4 3996.2 3999.3 4005.4 4005.8 5521.0 5662.9 5761.0 5773.9 5778.7 5482.5 5591.4 5606.9 5609.9 5612.1 5587.0 5597.4 5600.9 5602.6 5613.6 5380.2 5469.0 5486.4 5488.6 5490.4 5631.1 5640.1 5640.8 5644.9 5647.9 5461.8 5461.9 5462.6 5462.7 5463.2 05:14:16 INFO - PROCESS | 20498 | 05:14:16 INFO - PROCESS | 20498 | [#5] yui.html Cycles:180 Average:12128.46 Median:46216.50 stddev:13783.30 (29.8%) stddev-sans-first:13795.11 05:14:16 INFO - PROCESS | 20498 | Values: 672.1 721.7 771.4 787.8 807.1 11582.9 11628.5 11636.8 11744.1 11806.9 11484.5 11552.5 11563.7 11575.8 11576.7 617.3 628.7 629.9 784.8 809.7 799.3 800.4 805.5 806.6 806.8 842.7 848.0 848.7 848.9 848.9 649.3 656.5 830.1 844.0 844.1 631.4 631.7 631.9 632.2 632.8 11101.9 11243.4 11254.7 11273.9 11282.0 10965.5 11609.3 11650.5 11721.2 11905.0 9217.8 9293.3 9309.3 9324.3 9376.2 3170.1 3222.7 3263.2 3277.9 3294.2 39096.4 39368.4 39467.0 39508.5 39714.2 9053.2 9199.1 9228.1 9286.6 9291.8 17186.1 17215.3 17220.5 17227.0 17228.0 6361.6 6559.4 6587.6 6609.0 6850.9 3443.8 3510.9 3517.9 3518.3 3520.5 2522.8 2565.5 2568.6 2574.5 2579.8 464.5 466.3 470.6 492.9 497.9 417.2 526.1 532.0 532.3 549.0 7251.7 7400.6 7430.0 7549.9 7609.7 410.6 528.2 533.9 557.2 563.0 3468.5 3581.6 3588.8 3598.5 3668.5 47331.3 47810.5 47941.5 47969.3 48276.5 44218.3 45276.1 45280.3 46052.0 46381.0 40618.8 40958.8 41401.2 41578.8 41829.4 7019.9 7402.6 7792.0 7792.1 7974.6 30910.3 31123.8 31215.2 31298.8 31373.5 39050.0 40371.6 40479.2 40672.4 40870.2 9381.4 9539.9 9585.0 9589.9 9945.8 11043.0 11104.6 11213.3 11269.4 11517.4 10017.7 10305.6 10469.7 10482.1 10545.8 10101.6 10210.1 10346.3 10588.8 10825.3 10165.5 10217.0 10337.5 10579.6 10606.5 7899.2 8163.3 8336.8 8393.9 8699.4 8323.7 8415.0 8578.4 8699.5 8704.3 05:14:16 INFO - PROCESS | 20498 | -------- Summary: end -------- 05:14:16 INFO - PROCESS | 20498 | 05:14:16 INFO - TEST-INFO | 20498: exit 0 05:14:16 INFO - TEST-OK | dromaeo_css | took 1116364ms 05:14:16 INFO - TEST-START | kraken 05:14:16 INFO - operating with platform_type : linux_ 05:14:16 INFO - Initialising browser for kraken test... 05:14:16 INFO - TEST-INFO | started process 20681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNkIxhl/profile http://localhost:35281/getInfo.html) 05:14:20 INFO - PROCESS | 20681 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:14:20 INFO - PROCESS | 20681 | __metrics Screen width/height:1600/1200 05:14:20 INFO - PROCESS | 20681 | colorDepth:24 05:14:20 INFO - PROCESS | 20681 | Browser inner width/height: 1024/697 05:14:20 INFO - PROCESS | 20681 | __metrics 05:14:21 INFO - PROCESS | 20681 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:14:21 INFO - PROCESS | 20681 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:14:22 INFO - TEST-INFO | 20681: exit 0 05:14:22 INFO - Browser initialized. 05:14:22 INFO - Running cycle 1/1 for kraken test... 05:14:22 INFO - TEST-INFO | started process 20763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNkIxhl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:34 INFO - PROCESS | 20763 | RSS: Main: 150544384 05:14:34 INFO - PROCESS | 20763 | 05:14:36 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35281/tests/kraken/driver.html?testName=audio-beat-detection) 05:14:37 INFO - PROCESS | 20763 | RSS: Main: 184913920 05:14:37 INFO - PROCESS | 20763 | 05:14:40 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35281/tests/kraken/driver.html?testName=audio-dft) 05:14:40 INFO - PROCESS | 20763 | RSS: Main: 174489600 05:14:40 INFO - PROCESS | 20763 | 05:14:43 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35281/tests/kraken/driver.html?testName=audio-fft) 05:14:44 INFO - PROCESS | 20763 | RSS: Main: 161480704 05:14:44 INFO - PROCESS | 20763 | 05:14:46 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35281/tests/kraken/driver.html?testName=audio-oscillator) 05:14:46 INFO - PROCESS | 20763 | RSS: Main: 162648064 05:14:46 INFO - PROCESS | 20763 | 05:14:48 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:14:49 INFO - PROCESS | 20763 | RSS: Main: 165367808 05:14:49 INFO - PROCESS | 20763 | 05:14:52 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35281/tests/kraken/driver.html?testName=imaging-darkroom) 05:14:53 INFO - PROCESS | 20763 | RSS: Main: 165806080 05:14:53 INFO - PROCESS | 20763 | 05:14:56 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35281/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:57 INFO - PROCESS | 20763 | RSS: Main: 166039552 05:14:57 INFO - PROCESS | 20763 | 05:14:59 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35281/tests/kraken/driver.html?testName=json-parse-financial) 05:15:00 INFO - PROCESS | 20763 | RSS: Main: 165797888 05:15:00 INFO - PROCESS | 20763 | 05:15:02 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:15:02 INFO - PROCESS | 20763 | RSS: Main: 177266688 05:15:02 INFO - PROCESS | 20763 | 05:15:04 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35281/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:15:05 INFO - PROCESS | 20763 | RSS: Main: 175366144 05:15:05 INFO - PROCESS | 20763 | 05:15:07 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:15:08 INFO - PROCESS | 20763 | RSS: Main: 181858304 05:15:08 INFO - PROCESS | 20763 | 05:15:10 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:15:11 INFO - PROCESS | 20763 | RSS: Main: 188018688 05:15:11 INFO - PROCESS | 20763 | 05:15:13 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:15:14 INFO - PROCESS | 20763 | RSS: Main: 184385536 05:15:14 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | Cycle 1(1): loaded http://localhost:35281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35281/tests/kraken/driver.html?testName=ai-astar) 05:15:16 INFO - PROCESS | 20763 | RSS: Main: 244350976 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | __start_tp_report 05:15:16 INFO - PROCESS | 20763 | _x_x_mozilla_page_load 05:15:16 INFO - PROCESS | 20763 | _x_x_mozilla_page_load_details 05:15:16 INFO - PROCESS | 20763 | |i|pagename|runs| 05:15:16 INFO - PROCESS | 20763 | |0;ai-astar;110;111;107;113;112;112;100;110;111;102 05:15:16 INFO - PROCESS | 20763 | |1;audio-beat-detection;155;131;164;172;140;162;150;131;169;131 05:15:16 INFO - PROCESS | 20763 | |2;audio-dft;161;161;160;160;163;162;160;162;161;162 05:15:16 INFO - PROCESS | 20763 | |3;audio-fft;76;73;79;90;72;78;72;102;89;72 05:15:16 INFO - PROCESS | 20763 | |4;audio-oscillator;95;95;134;94;95;95;132;95;94;133 05:15:16 INFO - PROCESS | 20763 | |5;imaging-gaussian-blur;109;109;110;110;109;109;109;110;110;110 05:15:16 INFO - PROCESS | 20763 | |6;imaging-darkroom;146;146;146;146;146;146;147;146;146;146 05:15:16 INFO - PROCESS | 20763 | |7;imaging-desaturate;96;95;96;96;96;96;96;95;96;95 05:15:16 INFO - PROCESS | 20763 | |8;json-parse-financial;70;71;71;74;72;70;71;80;68;68 05:15:16 INFO - PROCESS | 20763 | |9;json-stringify-tinderbox;68;68;67;68;68;68;68;68;69;68 05:15:16 INFO - PROCESS | 20763 | |10;stanford-crypto-aes;88;82;87;82;81;83;82;81;83;83 05:15:16 INFO - PROCESS | 20763 | |11;stanford-crypto-ccm;128;125;125;123;124;125;126;127;119;121 05:15:16 INFO - PROCESS | 20763 | |12;stanford-crypto-pbkdf2;136;147;149;149;146;136;148;147;145;135 05:15:16 INFO - PROCESS | 20763 | |13;stanford-crypto-sha256-iterative;71;69;71;69;71;69;70;68;68;69 05:15:16 INFO - PROCESS | 20763 | __end_tp_report 05:15:16 INFO - PROCESS | 20763 | __start_cc_report 05:15:16 INFO - PROCESS | 20763 | _x_x_mozilla_cycle_collect,972 05:15:16 INFO - PROCESS | 20763 | __end_cc_report 05:15:16 INFO - PROCESS | 20763 | __startTimestamp1450703716300__endTimestamp 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | ------- Summary: start ------- 05:15:16 INFO - PROCESS | 20763 | Number of tests: 14 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:4.44 (4.0%) stddev-sans-first:4.69 05:15:16 INFO - PROCESS | 20763 | Values: 110.0 111.0 107.0 113.0 112.0 112.0 100.0 110.0 111.0 102.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:158.50 stddev:16.30 (10.3%) stddev-sans-first:17.20 05:15:16 INFO - PROCESS | 20763 | Values: 155.0 131.0 164.0 172.0 140.0 162.0 150.0 131.0 169.0 131.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.09 05:15:16 INFO - PROCESS | 20763 | Values: 161.0 161.0 160.0 160.0 163.0 162.0 160.0 162.0 161.0 162.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#3] audio-fft Cycles:10 Average:80.30 Median:77.00 stddev:10.14 (13.2%) stddev-sans-first:10.64 05:15:16 INFO - PROCESS | 20763 | Values: 76.0 73.0 79.0 90.0 72.0 78.0 72.0 102.0 89.0 72.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#4] audio-oscillator Cycles:10 Average:106.20 Median:95.00 stddev:18.50 (19.5%) stddev-sans-first:19.18 05:15:16 INFO - PROCESS | 20763 | Values: 95.0 95.0 134.0 94.0 95.0 95.0 132.0 95.0 94.0 133.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:15:16 INFO - PROCESS | 20763 | Values: 109.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 05:15:16 INFO - PROCESS | 20763 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:15:16 INFO - PROCESS | 20763 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#8] json-parse-financial Cycles:10 Average:71.50 Median:71.00 stddev:3.47 (4.9%) stddev-sans-first:3.64 05:15:16 INFO - PROCESS | 20763 | Values: 70.0 71.0 71.0 74.0 72.0 70.0 71.0 80.0 68.0 68.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 05:15:16 INFO - PROCESS | 20763 | Values: 68.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.39 (2.9%) stddev-sans-first:1.80 05:15:16 INFO - PROCESS | 20763 | Values: 88.0 82.0 87.0 82.0 81.0 83.0 82.0 81.0 83.0 83.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:125.00 stddev:2.71 (2.2%) stddev-sans-first:2.52 05:15:16 INFO - PROCESS | 20763 | Values: 128.0 125.0 125.0 123.0 124.0 125.0 126.0 127.0 119.0 121.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.80 Median:147.00 stddev:5.75 (3.9%) stddev-sans-first:5.36 05:15:16 INFO - PROCESS | 20763 | Values: 136.0 147.0 149.0 149.0 146.0 136.0 148.0 147.0 145.0 135.0 05:15:16 INFO - PROCESS | 20763 | 05:15:16 INFO - PROCESS | 20763 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.18 (1.7%) stddev-sans-first:1.12 05:15:16 INFO - PROCESS | 20763 | Values: 71.0 69.0 71.0 69.0 71.0 69.0 70.0 68.0 68.0 69.0 05:15:16 INFO - PROCESS | 20763 | -------- Summary: end -------- 05:15:16 INFO - PROCESS | 20763 | 05:15:17 INFO - TEST-INFO | 20763: exit 0 05:15:17 INFO - TEST-OK | kraken | took 60309ms 05:15:17 INFO - TEST-START | v8_7 05:15:17 INFO - operating with platform_type : linux_ 05:15:17 INFO - Initialising browser for v8_7 test... 05:15:17 INFO - TEST-INFO | started process 21010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgsUS8G/profile http://localhost:35281/getInfo.html) 05:15:21 INFO - PROCESS | 21010 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:15:21 INFO - PROCESS | 21010 | __metrics Screen width/height:1600/1200 05:15:21 INFO - PROCESS | 21010 | colorDepth:24 05:15:21 INFO - PROCESS | 21010 | Browser inner width/height: 1024/697 05:15:21 INFO - PROCESS | 21010 | __metrics 05:15:21 INFO - PROCESS | 21010 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:15:21 INFO - PROCESS | 21010 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:21 ERROR - PROCESS | 21010 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:15:22 INFO - TEST-INFO | 21010: exit 0 05:15:22 INFO - Browser initialized. 05:15:22 INFO - Running cycle 1/1 for v8_7 test... 05:15:22 INFO - TEST-INFO | started process 21090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgsUS8G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:34 INFO - PROCESS | 21090 | RSS: Main: 149827584 05:15:34 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | Cycle 1(1): loaded http://localhost:35281/tests/v8_7/run.html (next: http://localhost:35281/tests/v8_7/run.html) 05:15:56 INFO - PROCESS | 21090 | RSS: Main: 449208320 05:15:56 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | __start_tp_report 05:15:56 INFO - PROCESS | 21090 | _x_x_mozilla_page_load 05:15:56 INFO - PROCESS | 21090 | _x_x_mozilla_page_load_details 05:15:56 INFO - PROCESS | 21090 | |i|pagename|runs| 05:15:56 INFO - PROCESS | 21090 | |0;Richards;165.61775422325275 05:15:56 INFO - PROCESS | 21090 | |1;DeltaBlue;186.28912071535024 05:15:56 INFO - PROCESS | 21090 | |2;Encrypt;278.2415136338342 05:15:56 INFO - PROCESS | 21090 | |3;Decrypt;5196.891191709845 05:15:56 INFO - PROCESS | 21090 | |4;RayTrace;1976.2845849802372 05:15:56 INFO - PROCESS | 21090 | |5;Earley;788.6435331230284 05:15:56 INFO - PROCESS | 21090 | |6;Boyer;12708.860759493671 05:15:56 INFO - PROCESS | 21090 | |7;RegExp;26868.42105263158 05:15:56 INFO - PROCESS | 21090 | |8;Splay;615.7635467980296 05:15:56 INFO - PROCESS | 21090 | |9;NavierStokes;4835.748792270531 05:15:56 INFO - PROCESS | 21090 | __end_tp_report 05:15:56 INFO - PROCESS | 21090 | __startTimestamp1450703756282__endTimestamp 05:15:56 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | ------- Summary: start ------- 05:15:56 INFO - PROCESS | 21090 | Number of tests: 10 05:15:56 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | [#0] Richards Cycles:1 Average:165.62 Median:165.62 stddev:0.00 (0.0%) 05:15:56 INFO - PROCESS | 21090 | Values: 165.6 05:15:56 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | [#1] DeltaBlue Cycles:1 Average:186.29 Median:186.29 stddev:0.00 (0.0%) 05:15:56 INFO - PROCESS | 21090 | Values: 186.3 05:15:56 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 05:15:56 INFO - PROCESS | 21090 | Values: 278.2 05:15:56 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 05:15:56 INFO - PROCESS | 21090 | Values: 5196.9 05:15:56 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 05:15:56 INFO - PROCESS | 21090 | Values: 1976.3 05:15:56 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 05:15:56 INFO - PROCESS | 21090 | Values: 788.6 05:15:56 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | [#6] Boyer Cycles:1 Average:12708.86 Median:12708.86 stddev:0.00 (0.0%) 05:15:56 INFO - PROCESS | 21090 | Values: 12708.9 05:15:56 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 05:15:56 INFO - PROCESS | 21090 | Values: 26868.4 05:15:56 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | [#8] Splay Cycles:1 Average:615.76 Median:615.76 stddev:0.00 (0.0%) 05:15:56 INFO - PROCESS | 21090 | Values: 615.8 05:15:56 INFO - PROCESS | 21090 | 05:15:56 INFO - PROCESS | 21090 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:15:56 INFO - PROCESS | 21090 | Values: 4835.7 05:15:56 INFO - PROCESS | 21090 | -------- Summary: end -------- 05:15:56 INFO - PROCESS | 21090 | 05:15:57 INFO - TEST-INFO | 21090: exit 0 05:15:57 INFO - TEST-OK | v8_7 | took 39972ms 05:15:57 INFO - SUITE-END | took 1216s 05:15:57 INFO - Completed test suite (00:20:16) 05:15:57 INFO - Working with test: dromaeo_css 05:15:57 INFO - Generating results file: dromaeo_css 05:15:57 INFO - Working with test: kraken 05:15:57 INFO - Generating results file: kraken 05:15:57 INFO - javascript benchmark 05:15:57 INFO - Working with test: v8_7 05:15:57 INFO - Generating results file: v8_7 05:15:57 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 05:15:57 INFO - process_Request line: dromaeo_css 6374.97 graph.html#tests=[[72,203,35]] 05:15:57 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:57 INFO - process_Request line: kraken 1518.60 graph.html#tests=[[232,203,35]] 05:15:57 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:15:57 INFO - process_Request line: v8_7 19702.39 graph.html#tests=[[230,203,35]] 05:15:57 INFO - RETURN: dromaeo_css: 6374.97 05:15:57 INFO - RETURN: kraken: 1518.60 05:15:57 INFO - RETURN: v8_7: 19702.39 05:15:57 INFO - javascript benchmark 05:15:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2553.9106131285403, 2636.7626913577774, 2645.96031059534, 2665.746754058365, 2666.49336626041, 4256.723312984662, 4418.160549495594, 4522.706024108435, 4531.45622525297, 4532.4334458192725, 4436.600705936473, 4446.133004064209, 4535.3877226574405, 4582.931256031162, 4587.24310488769, 4017.5178978522617, 4096.549379568245, 4128.75227486351, 4252.936205956913, 4288.099499105176, 4237.449131612886, 4302.827886884521, 4304.892377690551, 4307.913841723163, 4329.0, 4008.559058503577, 4055.026793569522, 4109.3425051991835, 4125.876223713293, 4139.503259608836, 4169.749815011079, 4194.580541945811, 4217.472815898012, 4229.6404805591565, 4248.044190057243, 3999.0, 4179.665626749853, 4188.204241194163, 4196.412502249687, 4221.155768846213, 4337.934930976038, 4398.142362239365, 4434.357018232338, 4439.955600443986, 4466.731996080245, 4825.951740482586, 4832.589229915461, 4855.975720121377, 4861.659683822134, 4901.926471102936, 4669.299605059235, 4879.4388645305535, 4883.096627123993, 4885.169521181372, 4935.35840340757, 4398.274284743045, 4478.798454069574, 4489.102179564067, 4509.075639493896, 4517.548245175456, 4896.36347274852, 4988.575971042502, 4990.875228119254, 4992.850214493571, 5035.345405097314, 4521.683482156283, 4767.95232047682, 4798.088363210979, 4800.927986080212, 4833.202521583969, 4703.294505824086, 4785.234362501983, 4785.784639691222, 4790.377250957354, 4795.184818580849, 4789.353437285922, 4805.063012712488, 4806.110869489155, 4807.975960120177, 4810.037992401533, 4785.186518291899, 4791.5687588117235, 4793.1372352976105, 4793.616510679138, 4825.445073816556, 3906.277338692351, 4016.136530645925, 4019.0756126090578, 4028.7582745035393, 4061.898452538651, 3475.721942244614, 3520.119970007498, 3535.681788639035, 3555.964440355615, 3571.375009373401, 4195.391668208093, 4197.412362269285, 4209.968557703382, 4218.578142185757, 4242.53332133465, 4660.603848672833, 4780.020095880336, 4780.306855505932, 4798.47216806151, 4852.975735121302, 4127.153933443637, 4185.24665560196, 4194.454720886326, 4226.197022565702, 4234.851780187741, 4240.957590424056, 4280.336547835091, 4286.485621725413, 4287.485501739811, 4321.2005778931, 4421.226285399978, 4521.36700861873, 4529.932051019171, 4578.848284049504, 4632.189366860854, 4680.672352935398, 4780.95219047805, 4795.376601041842, 4801.351817504592, 4831.9275210871165, 4581.679282450196, 4649.628029757679, 4666.0, 4670.626349892068, 4702.717836929795, 4669.953300466952, 4790.760461976817, 4796.712197268175, 4816.638752093677, 4825.203841366276, 4693.225617773166, 4742.312364707029, 4764.8332308369045, 4771.379720636295, 4805.231163013901, 4690.601298889496, 4755.904881902412, 4770.403699537558, 4773.284007398918, 4813.95186048149, 4515.706479078849, 4619.122366750306, 4621.537846215351, 4750.572448479654, 4765.999140180601, 4420.53584373649, 4467.15124126415, 4479.910401792011, 4515.593596576324, 4522.253828118323, 4686.976565117153, 4736.73947932867, 4738.289256611398, 4742.952570474389, 4748.833790817304, 4390.165868484977, 4482.529334419839, 4492.2587773017085, 4610.561996610317, 4634.629229661687], "unit": "score", "name": "dojo.html", "value": 4423.373450421472}, {"lowerIsBetter": false, "replicates": [513.8766695992962, 514.9382074151102, 520.7838746920029, 530.625908734342, 541.9647722898014, 26032.088876889313, 35112.29775404491, 35662.64337356626, 35715.464268036, 35829.46255806158, 39720.80139599298, 40240.597594024126, 40313.59686403135, 40313.59686403135, 40341.39487907684, 7015.2984701529695, 7118.0390647262475, 7984.560849153294, 8153.510789352628, 8165.2243036911395, 10087.596496140182, 10342.948285258562, 10438.373697578132, 10460.581576736922, 10466.110380617656, 10166.288359814778, 10281.383117012965, 10283.074523292902, 10285.485725713721, 10291.073803357696, 7139.178994415631, 7292.19785823559, 10019.849702254473, 10025.749356266078, 10250.589976400935, 9936.105750482418, 10053.949730251303, 10055.245856560787, 10056.497175141214, 10060.69817905464, 37109.62890371089, 37676.43485347722, 37695.62304376976, 37716.62283377159, 37751.622483775085, 2853.1725799518113, 2902.6226590543306, 3008.9849550752106, 3401.693847553707, 3484.4947482615135, 28156.0, 28409.71590284112, 28443.431131377256, 28731.138065858057, 29083.0, 3254.6908043735807, 3266.5590145330552, 3320.634730179678, 3327.317899830529, 3375.5611770469927, 215410.0, 217206.99999999843, 217396.0, 217519.0, 217863.0, 51388.48611513837, 52938.47061529335, 61925.0, 63157.36842631607, 63284.683576581825, 55235.0, 55266.44733552694, 55550.44449555533, 55571.44428555744, 55665.0, 12988.0, 13098.410571524304, 13150.934245328712, 13184.73630527384, 13184.802227966587, 9566.091221333962, 9571.37786043905, 9622.422654640744, 9630.374025688308, 9638.614455421844, 19472.80527194738, 19668.803311966698, 19708.901455492916, 19720.605587888447, 19785.901070494845, 7800.492967957065, 7865.685372585032, 7944.6822127114265, 7979.5611241382285, 7999.880001799977, 917.5916717060844, 942.8020115775627, 943.9056094390506, 976.7753416714196, 1007.1087087927237, 23869.283247705178, 23995.880020599787, 24119.517609647708, 24145.637815432783, 24957.50722253343, 967.5549247346158, 979.5004547680734, 1000.46475135802, 1033.0083120204538, 1082.7130810335268, 13921.443142274398, 13947.648987156357, 14036.087654302437, 14071.859281407054, 14288.214148221947, 259308.0, 263948.0, 264006.0, 264206.14763114275, 264516.0, 44978.10043799106, 45146.54853451424, 45433.0, 45484.77257613691, 45573.5442645576, 1198.6344165029575, 1203.3080978437433, 1215.1979693402488, 1215.5563219424846, 1216.0636310041396, 24736.0, 25555.233342999738, 26046.869765651052, 26248.212553623423, 26360.604590931536, 40487.392689110275, 40742.0, 40907.59092409038, 40953.79523102365, 41035.7948210257, 237481.0, 238945.0, 238964.0, 292185.0, 304141.0, 27408.862955685094, 27486.0, 27520.0, 27627.171184864485, 27876.30309242285, 35194.0, 39448.2110357797, 39550.60449395469, 39840.40239396354, 40244.1951160981, 29927.401451970403, 30138.54792178163, 30353.392932141676, 38004.429933551575, 39916.60083399129, 31501.842490788316, 33376.33247334991, 33494.49758253579, 33551.664483354856, 33608.0, 32888.50667239945, 33120.17199569933, 33203.667963320055, 37715.62284377231, 38456.80771596236, 29229.85385073061, 30192.0, 30501.0, 30737.231569210948, 30779.692203077684, 23642.52714945726, 23719.288421347388, 23800.642990355504, 24037.278881633578, 24136.396590085387], "unit": "score", "name": "ext.html", "value": 17229.693538217813}, {"lowerIsBetter": false, "replicates": [294.4405629304322, 303.9392121575687, 305.17298122089136, 309.1020585199994, 316.13064073797057, 12643.620691379274, 13059.934700326485, 15281.541553753392, 15400.152991585472, 15777.605559860995, 15273.923630381832, 15599.220038998033, 15911.522654320388, 15922.203889805522, 15936.282867270971, 4889.608831293505, 6233.3143354231, 6435.806925792233, 6442.935570644304, 6446.774362897299, 4067.32889073304, 4227.175700738358, 6355.68221588921, 6369.93630063698, 6684.29814869439, 6391.744330226786, 6662.034005069262, 6666.366695163976, 6667.799966001027, 6704.396604305612, 6689.732410703566, 6718.294579069225, 6724.260331363571, 6727.159105111837, 6731.93268067318, 6253.405926436982, 6422.068800024017, 6424.196975378078, 6426.710798014101, 6433.45597056703, 21085.5782884343, 21093.47266318339, 21551.67672484914, 21676.0, 21795.455113622127, 1903.980960190408, 1964.7544056992876, 1974.131382191831, 2069.193014724259, 2092.665173572221, 13344.0, 13349.0, 13388.799168012487, 13599.728005439836, 13947.860521394758, 1751.448293787453, 1823.0429024761972, 1826.5159732670852, 1867.1317837205765, 1873.3724202392216, 60345.698271508365, 64102.358976410105, 64559.0, 64719.0, 64946.3505364945, 15479.613009674624, 15522.37910483568, 15551.14468704232, 15562.533124006071, 15681.764773528406, 23432.88283558571, 23440.187177538806, 23786.88106559456, 23833.880830595735, 23844.64233036506, 8552.401331906707, 8624.78438039054, 8652.307815374756, 8731.083236260229, 8737.650493980169, 7292.525985810906, 7322.0, 7324.853502929912, 7351.8162045949275, 7378.815529611803, 6632.602043877383, 7567.621618919032, 7720.266574675396, 7854.8429031419055, 7862.764117076496, 2507.6614657021432, 2946.425447037807, 2976.985115074454, 2980.6125203723377, 2985.7014298570402, 751.6054071612447, 793.123598423745, 826.5454000299811, 857.8884744983237, 919.4667093085994, 15462.536123916301, 15860.603484912739, 15955.441559545361, 16170.514884553482, 16225.594360140854, 851.5231470376609, 871.2246100970142, 913.9497327647043, 915.7390143809116, 938.1462868789505, 8967.237784788236, 8988.10118988109, 9100.317476189311, 9129.726108216764, 9231.522956326955, 419344.0, 424678.0, 429295.0, 429663.0, 429792.31869131303, 61839.0, 63479.74763280744, 72565.0, 75089.62455187799, 76412.61793690996, 1007.1388962437157, 1022.1209759606733, 1028.2493779540828, 1036.7084506691226, 1040.9115225205942, 13756.86243137596, 14324.713505730035, 14366.425342986164, 14375.353109110325, 14483.986120971853, 32805.34389312248, 33387.33225335431, 33712.49431258582, 34869.651303487655, 34928.30143397169, 41140.58859411367, 41161.38257926074, 41735.7913210432, 42084.1583168341, 42254.366184506645, 8368.41421100517, 8672.826543469222, 8761.649534018568, 8765.517896515752, 8767.035626080999, 10085.0, 10313.535890884777, 15439.150846703089, 15850.128242946748, 15861.365545378518, 13010.089293749346, 13279.136856104322, 13533.932330338286, 13710.588682339545, 13923.094998825043, 13111.529463190245, 13862.93068534651, 14043.227622480861, 14229.0, 14533.34599942984, 13699.315034248448, 14079.859201407855, 14250.073745206528, 14449.205293708947, 14503.78244326357, 8116.594170291343, 8349.165083491846, 8512.40413171072, 8517.48895066298, 8783.0, 12837.807432888701, 12974.80537791915, 13123.146995445266, 13232.603021909357, 13507.932460337635], "unit": "score", "name": "jquery.html", "value": 9217.288967159611}, {"lowerIsBetter": false, "replicates": [1435.2895316818176, 1637.181409295352, 1686.586786237372, 1712.0498123541438, 1747.5893165106197, 6143.846403839906, 6993.405560527355, 7120.893186602192, 7121.465890058241, 7130.500864939457, 7124.109486314211, 7299.927000729991, 7300.634968251579, 7315.305046020633, 7319.9268007319915, 1717.1414292853574, 1745.6421433606145, 1996.6905129704846, 2074.3776866939897, 2109.177420805887, 2081.3235698398007, 2093.037202886674, 2099.1078791513623, 2100.2544096845627, 2100.6008858316945, 2024.1093918675735, 2024.180207016161, 2063.2366024570856, 2066.5350296183387, 2066.8449866260016, 2033.593281343737, 2051.364077136078, 2085.906134223956, 2114.8202402795782, 2119.4277545062746, 2125.415510734545, 2137.1771867830844, 2152.397328747953, 2152.6017686728005, 2158.8057074863336, 7191.676374563157, 7280.2719728027305, 7290.161631412402, 7292.0, 7298.817529561803, 4089.815958281855, 4135.0902801383645, 4162.250794856925, 4169.061961058768, 4231.61915427613, 2569.0622922633106, 2605.1793684989166, 2613.085420102968, 2621.2005338371787, 2624.4357463145516, 795.9801004974864, 798.7923139983646, 801.8837268596021, 816.9183081691842, 824.9175082491763, 9470.526473676358, 9476.0, 9478.573464194058, 9493.857592136124, 9497.050294970448, 3859.9421008684894, 3860.0735823402742, 3884.223155368881, 3886.436466712311, 3943.7830919299713, 8290.958545207235, 8300.916990830136, 8304.211099945496, 8316.293115085164, 8318.459300145592, 4173.770442625624, 4196.664266858644, 4201.432806571135, 4211.410402543646, 4215.135897141079, 3814.0464883779055, 3816.0, 3819.961800382016, 3822.694184465236, 3827.196288779332, 3099.969000309968, 3165.6042994625673, 3302.620198677183, 3430.519727238189, 3431.073610125302, 1046.2205656785743, 1051.1590727418188, 1053.210092430677, 1053.8028211179624, 1062.6811956413046, 857.3741168946704, 866.5883705240086, 870.216804875617, 875.4003507597316, 1109.4341885638382, 6846.041554182419, 6877.828054298682, 6888.655567221619, 6918.757843475454, 6927.93072069283, 1047.2983101322131, 1063.8510608514814, 1081.8323159910226, 1091.879893211746, 1094.6661268313242, 5280.9207861882105, 5302.072137376021, 5314.556895699891, 5348.438413966555, 5355.571554275649, 8582.613782379807, 8777.561121943878, 8855.64577416909, 8863.379563430626, 8882.955585222033, 8561.315094792402, 8618.052014278424, 8747.868781968276, 8751.693690720795, 8756.693515726918, 6805.897911531331, 6879.174499060145, 6919.065926099912, 6924.826879327957, 6928.584284942919, 6282.748690052529, 6374.808755737336, 6379.298277189599, 6632.668366581555, 6656.7670131545165, 7568.659410326439, 7709.614519273901, 7721.112072111779, 7773.3004029637605, 7813.0, 7839.725609603636, 7865.3314468268545, 8031.638576263966, 8049.4767840092545, 8095.150009248944, 6474.611523308428, 6552.148220731275, 6560.048792925095, 6565.704543295658, 6575.243846957661, 5877.970610147093, 5957.225560677084, 6697.832554186184, 6865.382115609619, 7119.786406407816, 6409.615423074631, 6526.477881769542, 6547.345265473415, 6635.303293154149, 6647.933520664925, 6369.235691717024, 6404.359564043559, 6412.198475190601, 6539.476841852736, 6589.7364105435245, 6562.081308616702, 6567.9671601641685, 6568.934310657023, 6573.276939536551, 6580.078788969452, 6072.787452439144, 6086.6348019119, 6119.265688117454, 6148.1699970503405, 6149.938500614937, 6080.878382432238, 6090.725917333642, 6177.505799535937, 6183.196184495987, 6187.907181392373], "unit": "score", "name": "mootools.html", "value": 4096.574689711547}, {"lowerIsBetter": false, "replicates": [283.3709165652252, 291.1106569430389, 293.6344251406999, 297.3710602076606, 302.0349981808124, 5296.285001524798, 5332.360116785986, 5350.384705758839, 5365.919511207335, 5387.676739395639, 5257.211418287259, 5266.8419947401635, 5269.683818970864, 5280.815171468999, 5287.206918962158, 4117.464729585165, 4118.361653943643, 4120.629143377096, 4122.051928056549, 4126.844483544597, 3870.632289932452, 3966.2464131814863, 3991.5609282978994, 4055.655269302113, 4063.2686116499017, 4019.31671615826, 4041.979790101045, 4084.0810817566107, 4093.0585965228015, 4098.303288440958, 3818.3127037133304, 3908.5309762828642, 4084.0810817565957, 4089.4683691119963, 4094.5905409459115, 3501.3872572299747, 3567.2687099144873, 3570.357335679577, 3576.409892367756, 3585.2470981094, 5049.141645920203, 5053.36832895888, 5057.2666963290485, 5064.417591976933, 5069.518395752398, 4672.6261899047995, 4673.439187297512, 4673.696209746389, 4685.5314468553215, 4700.858974230779, 5391.919121213185, 5464.590155738336, 5515.972420137914, 5542.501174894279, 5550.833474995757, 3859.6526312632, 3861.691064714816, 3862.6909847212437, 3869.0520822398694, 3870.5161854768153, 5841.153032810261, 5843.181954526327, 5849.356570777211, 5860.443257890493, 5863.003289440848, 3973.1854969731135, 3974.3839704845795, 3975.185087057146, 3977.343738283209, 3984.2230765001127, 3727.2731817295366, 4043.8989025274013, 4043.9687879590515, 4044.2315959967514, 4047.0287131088326, 4320.848770293088, 4425.446819147606, 4482.574155455227, 4527.637788976874, 4659.440867095903, 5487.862803429866, 5558.138488534284, 5566.944330556643, 5571.247881536022, 5572.665640061609, 1382.5299398204659, 1423.4733148735033, 1425.6792221750022, 1425.7291114688176, 1425.836028856674, 953.8378475659155, 958.4872093430121, 959.5010594490826, 985.3545927417409, 987.1362557761959, 4904.730239836843, 4908.754562271872, 4914.311996320518, 4914.8771280718265, 4924.4090709115135, 5760.36635970043, 5761.251037365116, 5768.826935191951, 5773.076307790733, 5776.249087618583, 4867.0, 4898.436679781871, 4902.1176188285735, 4905.901881962341, 4911.214205727138, 3029.712177343149, 3066.141480385451, 3103.379324135182, 3106.689331066875, 3108.5492603572357, 5483.150111732688, 5483.533899618497, 5485.9725701371235, 5490.0, 5493.450654934474, 5896.616719913192, 5942.821715348547, 5945.256842894638, 5948.85127871798, 5950.285965684146, 5470.288862447856, 5470.617056806065, 5474.863128421821, 5478.315210598676, 5484.204790305464, 5626.718664066699, 5765.769369225184, 5774.220480235283, 5778.335491418541, 5778.451047150514, 5670.0, 5672.014794821779, 5678.14827775837, 5681.062624667049, 5684.602077854511, 5478.233047373451, 5491.725413729378, 5492.505674489315, 5493.450654934474, 5494.80768173112, 3914.412838074312, 3996.1608062306077, 3999.280129576704, 4005.35914253718, 4005.8197381118503, 5521.0, 5662.85842853932, 5761.02062649359, 5773.884522309446, 5778.653280803165, 5482.451754824486, 5591.412901645269, 5606.915896261477, 5609.943900560942, 5612.102063669793, 5586.972065139648, 5597.412271711411, 5600.85997850057, 5602.607817452739, 5613.57898157648, 5380.166074258496, 5469.0, 5486.423925487767, 5488.588355873405, 5490.368607610176, 5631.099024156116, 5640.0693885508435, 5640.830775076754, 5644.9435505644415, 5647.915281270702, 5461.808836690697, 5461.9453805461435, 5462.617616766788, 5462.6995515247045, 5463.207834864002], "unit": "score", "name": "prototype.html", "value": 4166.649810712707}, {"lowerIsBetter": false, "replicates": [672.0591172358701, 721.7113154738104, 771.3983093187314, 787.8148635070761, 807.1484583764127, 11582.884171158286, 11628.534858605657, 11636.767264654713, 11744.119191060683, 11806.940965295184, 11484.483198256077, 11552.537898484072, 11563.65309040728, 11575.768484630302, 11576.652700419001, 617.253123720299, 628.6699482771559, 629.8740251949605, 784.8351846112323, 809.7327881798992, 799.3085980626774, 800.3597122302135, 805.4522924411398, 806.5644551941945, 806.8265322955564, 842.6839935024366, 847.995760021199, 848.7368915636173, 848.9023762267326, 848.9405741598091, 649.3344322069869, 656.4879394072631, 830.0827585517976, 844.0040751912802, 844.0673056272852, 631.4380201620561, 631.7409861956621, 631.9115323854664, 632.1844820182006, 632.8006677896448, 11101.888981110167, 11243.381614011227, 11254.662360129209, 11273.943630281878, 11282.0, 10965.50655220517, 11609.303441793434, 11650.533978640844, 11721.23811952229, 11905.0, 9217.815643687089, 9293.303002274857, 9309.255259579286, 9324.254059675277, 9376.156145946898, 3170.1282147409415, 3222.6616205298574, 3263.167892187477, 3277.918052048694, 3294.2423242654086, 39096.413553796716, 39368.409473857915, 39467.0, 39508.45652749913, 39714.20571588581, 9053.185213330831, 9199.126083022102, 9228.077192280718, 9286.628534858664, 9291.814163716688, 17186.054766987934, 17215.311387544607, 17220.483385498454, 17227.0, 17228.0, 6361.5546911716665, 6559.409653131241, 6587.571807832475, 6608.966955165193, 6850.897236541456, 3443.810590417551, 3510.894673159758, 3517.9296414071573, 3518.3139287838626, 3520.4895290183294, 2522.848629082261, 2565.538203123456, 2568.6403903453534, 2574.4593635336414, 2579.8065145113815, 464.4565857946211, 466.31218952045464, 470.64231184299496, 492.9309896614477, 497.855621869661, 417.2031419987809, 526.139761489959, 531.9998403002331, 532.2521856791215, 548.9835304940858, 7251.7099316027825, 7400.555966642019, 7429.962850185714, 7549.9245007549225, 7609.733659321897, 410.6263300396625, 528.1760453692252, 533.9172428273624, 557.150345722776, 563.0, 3468.514407982884, 3581.5702115746276, 3588.820558972041, 3598.5142005829402, 3668.486411902336, 47331.290030649565, 47810.521894781305, 47941.5205847937, 47969.28046079312, 48276.5172348272, 44218.33672494915, 45276.09447811025, 45280.3207951881, 46052.0, 46381.0, 40618.79690601528, 40958.79520602438, 41401.1719765603, 41578.79210603928, 41829.37255941163, 7019.894701579378, 7402.592857392895, 7791.961040194763, 7792.103908050647, 7974.561399123104, 30910.29076510743, 31123.84438077795, 31215.219619509695, 31298.843505782326, 31373.52939705952, 39050.0, 40371.59628403796, 40479.19041619092, 40672.38991415072, 40870.1825963485, 9381.390209636626, 9539.856902146335, 9584.993575674733, 9589.856152157863, 9945.751356216153, 11043.0, 11104.61133860311, 11213.327200368005, 11269.436528173395, 11517.424128793695, 10017.69946901594, 10305.639302624371, 10469.68590942273, 10482.056614904695, 10545.789084218119, 10101.646442374482, 10210.081092701395, 10346.27576069698, 10588.788224235626, 10825.296355736851, 10165.54255058539, 10217.0, 10337.534810933677, 10579.576816927236, 10606.46967651599, 7899.210078992055, 8163.346932245525, 8336.83326333482, 8393.874091888505, 8699.43453675509, 8323.725848771539, 8414.95792521058, 8578.356623253156, 8699.521526316114, 8704.26013788835], "unit": "score", "name": "yui.html", "value": 5597.295985201145}], "name": "dromaeo_css", "value": 6374.972981636916}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 113.0, 112.0, 112.0, 100.0, 110.0, 111.0, 102.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [155.0, 131.0, 164.0, 172.0, 140.0, 162.0, 150.0, 131.0, 169.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 163.0, 162.0, 160.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 79.0, 90.0, 72.0, 78.0, 72.0, 102.0, 89.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 134.0, 94.0, 95.0, 95.0, 132.0, 95.0, 94.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 74.0, 72.0, 70.0, 71.0, 80.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [88.0, 82.0, 87.0, 82.0, 81.0, 83.0, 82.0, 81.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [128.0, 125.0, 125.0, 123.0, 124.0, 125.0, 126.0, 127.0, 119.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [136.0, 147.0, 149.0, 149.0, 146.0, 136.0, 148.0, 147.0, 145.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.8}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 71.0, 69.0, 71.0, 69.0, 70.0, 68.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1518.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.61775422325275], "unit": "score", "name": "Richards", "value": 213.15347599999996}, {"lowerIsBetter": false, "replicates": [186.28912071535024], "unit": "score", "name": "DeltaBlue", "value": 354.92142400000006}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [12708.860759493671], "unit": "score", "name": "Boyer", "value": 52.440813745019945}, {"lowerIsBetter": false, "replicates": [26868.42105263158], "unit": "score", "name": "RegExp", "value": 33.90541625857002}, {"lowerIsBetter": false, "replicates": [615.7635467980296], "unit": "score", "name": "Splay", "value": 132.34138400000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19702.38894967895}]} 05:15:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19702.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1518.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6374.97"}}} 05:15:57 INFO - Return code: 0 05:15:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:15:57 ERROR - # TBPL SUCCESS # 05:15:57 INFO - Running post-action listener: _resource_record_post_action 05:15:57 INFO - Running post-run listener: _resource_record_post_run 05:15:58 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 565641216; Read time: 44; Write time: 478152 05:15:58 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244965376; Read time: 0; Write time: 280100 05:15:58 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320675840; Read time: 44; Write time: 198052 05:15:58 INFO - Running post-run listener: _upload_blobber_files 05:15:58 INFO - Blob upload gear active. 05:15:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:15:58 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 05:15:58 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'] 05:15:58 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 05:15:59 INFO - (blobuploader) - INFO - Open directory for files ... 05:15:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:15:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:15:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:59 INFO - (blobuploader) - INFO - Done attempting. 05:15:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:15:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:16:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:00 INFO - (blobuploader) - INFO - Done attempting. 05:16:00 INFO - (blobuploader) - INFO - Iteration through files over. 05:16:00 INFO - Return code: 0 05:16:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:16:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:16:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/af84d70aca507e44e857c99e23167134e3304cce293efe67868b587dd3200361df59db8e01dc9517a402dbc5217aae7a1fff663f6e83ef4131dd200005142671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/1bbe3dc08df41a834af4c998ef535e0c9c9aef887cf567de8612b789d75d92cf0ec8d2791238a37d8245bfc719b0c792a2131eca27fede2ed64011810f1a8bf3"} 05:16:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:16:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:16:00 INFO - Contents: 05:16:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/af84d70aca507e44e857c99e23167134e3304cce293efe67868b587dd3200361df59db8e01dc9517a402dbc5217aae7a1fff663f6e83ef4131dd200005142671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/1bbe3dc08df41a834af4c998ef535e0c9c9aef887cf567de8612b789d75d92cf0ec8d2791238a37d8245bfc719b0c792a2131eca27fede2ed64011810f1a8bf3"} 05:16:00 INFO - Copying logs to upload dir... 05:16:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.225510 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-21 05:16:00.708531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 05:16:00.711851) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199 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/af84d70aca507e44e857c99e23167134e3304cce293efe67868b587dd3200361df59db8e01dc9517a402dbc5217aae7a1fff663f6e83ef4131dd200005142671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/1bbe3dc08df41a834af4c998ef535e0c9c9aef887cf567de8612b789d75d92cf0ec8d2791238a37d8245bfc719b0c792a2131eca27fede2ed64011810f1a8bf3"} build_url:https://queue.taskcluster.net/v1/task/wdNZ650RS8erOkzuqRvZjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/wdNZ650RS8erOkzuqRvZjw/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/af84d70aca507e44e857c99e23167134e3304cce293efe67868b587dd3200361df59db8e01dc9517a402dbc5217aae7a1fff663f6e83ef4131dd200005142671", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/1bbe3dc08df41a834af4c998ef535e0c9c9aef887cf567de8612b789d75d92cf0ec8d2791238a37d8245bfc719b0c792a2131eca27fede2ed64011810f1a8bf3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 05:16:00.737461) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:16:00.737915) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1450702314.47908-1871228199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:16:00.824700) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 05:16:00.825321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 05:16:00.825900) ========= ========= Total master_lag: 0.26 =========