builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1451099244.56 results: success (0) buildid: 20151225175148 builduid: 8b5c74a5e2214f4a83789af0ecc2f727 revision: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.562315) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.562867) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.563170) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006320 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.593885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.594182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.621020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.621485) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.672465) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.672742) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.673085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.673372) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-25 19:07:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 210M=0s 2015-12-25 19:07:25 (210 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.851594) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.852141) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018363 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:24.906372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-25 19:07:24.906741) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 4a559a618d6798eb9a8fdc559f5a7a00085e2062 --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 4a559a618d6798eb9a8fdc559f5a7a00085e2062 --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=cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-25 19:07:25,250 truncating revision to first 12 chars 2015-12-25 19:07:25,250 Setting DEBUG logging. 2015-12-25 19:07:25,250 attempt 1/10 2015-12-25 19:07:25,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/4a559a618d67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-25 19:07:26,566 unpacking tar archive at: b2g-inbound-4a559a618d67/testing/mozharness/ program finished with exit code 0 elapsedTime=1.624636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-25 19:07:26.549129) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:26.549902) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:26.560786) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:26.561047) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 19:07:26.561407) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-25 19:07:26.561685) ========= /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=cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:07:26 INFO - MultiFileLogger online at 20151225 19:07:26 in /builds/slave/test 19:07:26 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 19:07:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:07:26 INFO - {'append_to_log': False, 19:07:26 INFO - 'base_work_dir': '/builds/slave/test', 19:07:26 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 19:07:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:07:26 INFO - 'branch': 'B2G-Inbound-Non-PGO', 19:07:26 INFO - 'buildbot_json_path': 'buildprops.json', 19:07:26 INFO - 'config_files': ('talos/linux_config.py',), 19:07:26 INFO - 'default_actions': ('clobber', 19:07:26 INFO - 'read-buildbot-config', 19:07:26 INFO - 'download-and-extract', 19:07:26 INFO - 'populate-webroot', 19:07:26 INFO - 'create-virtualenv', 19:07:26 INFO - 'install', 19:07:26 INFO - 'run-tests'), 19:07:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:07:26 INFO - 'download_minidump_stackwalk': True, 19:07:26 INFO - 'download_symbols': 'ondemand', 19:07:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:07:26 INFO - 'tooltool.py': '/tools/tooltool.py', 19:07:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:07:26 INFO - '/tools/misc-python/virtualenv.py')}, 19:07:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:07:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:07:26 INFO - 'installer_path': 'installer.exe', 19:07:26 INFO - 'log_level': 'info', 19:07:26 INFO - 'log_name': 'talos', 19:07:26 INFO - 'log_to_console': True, 19:07:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:07:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:07:26 INFO - 'opt_config_files': (), 19:07:26 INFO - 'pip_index': False, 19:07:26 INFO - 'sps_profile': False, 19:07:26 INFO - 'sps_profile_interval': 0, 19:07:26 INFO - 'suite': 'dromaeojs', 19:07:26 INFO - 'system_bits': '64', 19:07:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:07:26 INFO - 'title': 'talos-linux64-ix-010', 19:07:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:07:26 INFO - 'use_talos_json': True, 19:07:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:07:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:07:26 INFO - 'work_dir': 'build'} 19:07:26 INFO - ##### 19:07:26 INFO - ##### Running clobber step. 19:07:26 INFO - ##### 19:07:26 INFO - Running pre-action listener: _resource_record_pre_action 19:07:26 INFO - Running main action method: clobber 19:07:26 INFO - rmtree: /builds/slave/test/build 19:07:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:07:27 INFO - Running post-action listener: _resource_record_post_action 19:07:27 INFO - ##### 19:07:27 INFO - ##### Running read-buildbot-config step. 19:07:27 INFO - ##### 19:07:27 INFO - Running pre-action listener: _resource_record_pre_action 19:07:27 INFO - Running main action method: read_buildbot_config 19:07:27 INFO - Using buildbot properties: 19:07:27 INFO - { 19:07:27 INFO - "project": "", 19:07:27 INFO - "product": "firefox", 19:07:27 INFO - "script_repo_revision": "production", 19:07:27 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 19:07:27 INFO - "repository": "", 19:07:27 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 19:07:27 INFO - "buildid": "20151225175148", 19:07:27 INFO - "pgo_build": "False", 19:07:27 INFO - "basedir": "/builds/slave/test", 19:07:27 INFO - "buildnumber": 801, 19:07:27 INFO - "slavename": "talos-linux64-ix-010", 19:07:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:07:27 INFO - "platform": "ubuntu64_hw", 19:07:27 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 19:07:27 INFO - "branch": "b2g-inbound", 19:07:27 INFO - "repo_path": "integration/b2g-inbound", 19:07:27 INFO - "revision": "4a559a618d6798eb9a8fdc559f5a7a00085e2062", 19:07:27 INFO - "stage_platform": "linux64", 19:07:27 INFO - "builduid": "8b5c74a5e2214f4a83789af0ecc2f727", 19:07:27 INFO - "slavebuilddir": "test" 19:07:27 INFO - } 19:07:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:07:27 INFO - Running post-action listener: _resource_record_post_action 19:07:27 INFO - ##### 19:07:27 INFO - ##### Running download-and-extract step. 19:07:27 INFO - ##### 19:07:27 INFO - Running pre-action listener: _resource_record_pre_action 19:07:27 INFO - Running main action method: download_and_extract 19:07:27 INFO - mkdir: /builds/slave/test/build/tests 19:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:27 INFO - https://queue.taskcluster.net/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:07:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/test_packages.json 19:07:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/test_packages.json 19:07:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:07:28 INFO - Downloaded 1302 bytes. 19:07:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:07:28 INFO - Using the following test package requirements: 19:07:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:07:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:28 INFO - u'jsshell-linux-x86_64.zip'], 19:07:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:07:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:07:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:07:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:07:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:07:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:07:28 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')]} 19:07:28 INFO - https://queue.taskcluster.net/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/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 19:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/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 19:07:29 INFO - Downloaded 21942303 bytes. 19:07:29 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 19:07:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:29 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 19:07:30 INFO - Return code: 0 19:07:30 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 19:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:30 INFO - https://queue.taskcluster.net/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/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 19:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/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 19:07:32 INFO - Downloaded 21942303 bytes. 19:07:32 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 19:07:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:07:32 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 19:07:33 INFO - Return code: 0 19:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:33 INFO - https://queue.taskcluster.net/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/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 19:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/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 19:07:35 INFO - Downloaded 11132270 bytes. 19:07:35 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 19:07:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:35 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 19:07:35 INFO - Return code: 0 19:07:35 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')]} 19:07:35 INFO - https://queue.taskcluster.net/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/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 19:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EVWm9ngbQSeru8mdYqRw8g/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 19:07:40 INFO - Downloaded 53335105 bytes. 19:07:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:07:40 INFO - mkdir: /builds/slave/test/properties 19:07:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:07:40 INFO - Writing to file /builds/slave/test/properties/build_url 19:07:40 INFO - Contents: 19:07:40 INFO - build_url:https://queue.taskcluster.net/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:07:40 INFO - Running post-action listener: _resource_record_post_action 19:07:40 INFO - Running post-action listener: set_extra_try_arguments 19:07:40 INFO - ##### 19:07:40 INFO - ##### Running populate-webroot step. 19:07:40 INFO - ##### 19:07:40 INFO - Running pre-action listener: _resource_record_pre_action 19:07:40 INFO - Running main action method: populate_webroot 19:07:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:07:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:07:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:07:40 INFO - '--tppagecycles', 19:07:40 INFO - '7'], 19:07:40 INFO - 'tests': ['tsvgm']}}, 19:07:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:07:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:07:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:07:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:07:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:07:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:07:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:40 INFO - 'talos_options': ['--e10s'], 19:07:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:40 INFO - 'tests': ['damp', 'tps']}, 19:07:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:40 INFO - 'talos_options': ['--e10s'], 19:07:40 INFO - 'tests': ['damp', 'tps']}, 19:07:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:07:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:07:40 INFO - 'other': {'tests': ['a11yr', 19:07:40 INFO - 'ts_paint', 19:07:40 INFO - 'tpaint', 19:07:40 INFO - 'sessionrestore', 19:07:40 INFO - 'sessionrestore_no_auto_restore']}, 19:07:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:07:40 INFO - 'tests': ['a11yr', 19:07:40 INFO - 'ts_paint', 19:07:40 INFO - 'tpaint', 19:07:40 INFO - 'sessionrestore', 19:07:40 INFO - 'sessionrestore_no_auto_restore']}, 19:07:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:07:40 INFO - 'tests': ['a11yr', 19:07:40 INFO - 'ts_paint', 19:07:40 INFO - 'tpaint', 19:07:40 INFO - 'sessionrestore', 19:07:40 INFO - 'sessionrestore_no_auto_restore']}, 19:07:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:07:40 INFO - 'tests': ['a11yr', 19:07:40 INFO - 'ts_paint', 19:07:40 INFO - 'tpaint', 19:07:40 INFO - 'sessionrestore', 19:07:40 INFO - 'sessionrestore_no_auto_restore']}, 19:07:40 INFO - 'other_l64': {'tests': ['a11yr', 19:07:40 INFO - 'ts_paint', 19:07:40 INFO - 'tpaint', 19:07:40 INFO - 'sessionrestore', 19:07:40 INFO - 'sessionrestore_no_auto_restore']}, 19:07:40 INFO - 'other_nol64': {'tests': ['a11yr', 19:07:40 INFO - 'ts_paint', 19:07:40 INFO - 'tpaint', 19:07:40 INFO - 'sessionrestore', 19:07:40 INFO - 'sessionrestore_no_auto_restore']}, 19:07:40 INFO - 'svgr': {'tests': ['tsvgx', 19:07:40 INFO - 'tsvgr_opacity', 19:07:40 INFO - 'tart', 19:07:40 INFO - 'tscrollx', 19:07:40 INFO - 'cart']}, 19:07:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:07:40 INFO - 'tests': ['tsvgx', 19:07:40 INFO - 'tsvgr_opacity', 19:07:40 INFO - 'tart', 19:07:40 INFO - 'tscrollx', 19:07:40 INFO - 'cart']}, 19:07:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:40 INFO - 'tests': ['tp5o']}, 19:07:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:40 INFO - 'talos_options': ['--e10s'], 19:07:40 INFO - 'tests': ['tp5o']}, 19:07:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:40 INFO - 'talos_options': ['--xperf_path', 19:07:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:40 INFO - 'tests': ['tp5n']}, 19:07:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:40 INFO - 'talos_options': ['--e10s', 19:07:40 INFO - '--xperf_path', 19:07:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:40 INFO - 'tests': ['tp5n']}}, 19:07:40 INFO - 'talos.zip': {'path': '', 19:07:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:07:40 INFO - Running post-action listener: _resource_record_post_action 19:07:40 INFO - ##### 19:07:40 INFO - ##### Running create-virtualenv step. 19:07:40 INFO - ##### 19:07:40 INFO - Running pre-action listener: _resource_record_pre_action 19:07:40 INFO - Running main action method: create_virtualenv 19:07:40 INFO - Creating virtualenv /builds/slave/test/build/venv 19:07:40 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 19:07:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:07:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:07:40 INFO - Using real prefix '/usr' 19:07:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:07:40 INFO - Installing distribute.............................................................................................................................................................................................done. 19:07:42 INFO - Installing pip.................done. 19:07:42 INFO - Return code: 0 19:07:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f27ec9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c34dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc73d0>, '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 0x1c32ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', '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 19:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:07:42 INFO - Using env: {'DISPLAY': ':0', 19:07:42 INFO - 'HOME': '/home/cltbld', 19:07:42 INFO - 'LANG': 'en_US.UTF-8', 19:07:42 INFO - 'LANGUAGE': 'en_US:en', 19:07:42 INFO - 'LOGNAME': 'cltbld', 19:07:42 INFO - 'MAIL': '/var/mail/cltbld', 19:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:42 INFO - 'MOZ_NO_REMOTE': '1', 19:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:42 INFO - 'NO_EM_RESTART': '1', 19:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:42 INFO - 'PWD': '/builds/slave/test', 19:07:42 INFO - 'SHELL': '/bin/bash', 19:07:42 INFO - 'SHLVL': '1', 19:07:42 INFO - 'TERM': 'linux', 19:07:42 INFO - 'TMOUT': '86400', 19:07:42 INFO - 'USER': 'cltbld', 19:07:42 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', 19:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:42 INFO - '_': '/tools/buildbot/bin/python'} 19:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:07:42 INFO - Cleaning up... 19:07:42 INFO - Return code: 0 19:07:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f27ec9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c34dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc73d0>, '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 0x1c32ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', '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 19:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:07:42 INFO - Using env: {'DISPLAY': ':0', 19:07:42 INFO - 'HOME': '/home/cltbld', 19:07:42 INFO - 'LANG': 'en_US.UTF-8', 19:07:42 INFO - 'LANGUAGE': 'en_US:en', 19:07:42 INFO - 'LOGNAME': 'cltbld', 19:07:42 INFO - 'MAIL': '/var/mail/cltbld', 19:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:42 INFO - 'MOZ_NO_REMOTE': '1', 19:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:42 INFO - 'NO_EM_RESTART': '1', 19:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:42 INFO - 'PWD': '/builds/slave/test', 19:07:42 INFO - 'SHELL': '/bin/bash', 19:07:42 INFO - 'SHLVL': '1', 19:07:42 INFO - 'TERM': 'linux', 19:07:42 INFO - 'TMOUT': '86400', 19:07:42 INFO - 'USER': 'cltbld', 19:07:42 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', 19:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:42 INFO - '_': '/tools/buildbot/bin/python'} 19:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:43 INFO - Downloading/unpacking psutil>=0.7.1 19:07:43 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 19:07:43 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 19:07:43 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 19:07:43 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 19:07:43 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 19:07:43 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 19:07:44 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:07:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:07:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:44 INFO - Installing collected packages: psutil 19:07:44 INFO - Running setup.py install for psutil 19:07:44 INFO - building 'psutil._psutil_linux' extension 19:07:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:07:45 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 19:07:45 INFO - building 'psutil._psutil_posix' extension 19:07:45 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 19:07:45 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 19:07:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:45 INFO - Successfully installed psutil 19:07:45 INFO - Cleaning up... 19:07:45 INFO - Return code: 0 19:07:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:07:45 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')]} 19:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:45 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')]} 19:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:45 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 0x7f27ec9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c34dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc73d0>, '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 0x1c32ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', '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 19:07:45 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 19:07:45 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 19:07:45 INFO - Using env: {'DISPLAY': ':0', 19:07:45 INFO - 'HOME': '/home/cltbld', 19:07:45 INFO - 'LANG': 'en_US.UTF-8', 19:07:45 INFO - 'LANGUAGE': 'en_US:en', 19:07:45 INFO - 'LOGNAME': 'cltbld', 19:07:45 INFO - 'MAIL': '/var/mail/cltbld', 19:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:45 INFO - 'MOZ_NO_REMOTE': '1', 19:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:45 INFO - 'NO_EM_RESTART': '1', 19:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:45 INFO - 'PWD': '/builds/slave/test', 19:07:45 INFO - 'SHELL': '/bin/bash', 19:07:45 INFO - 'SHLVL': '1', 19:07:45 INFO - 'TERM': 'linux', 19:07:45 INFO - 'TMOUT': '86400', 19:07:45 INFO - 'USER': 'cltbld', 19:07:45 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', 19:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:45 INFO - '_': '/tools/buildbot/bin/python'} 19:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:07:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:07:47 INFO - Installing collected packages: mozsystemmonitor 19:07:47 INFO - Running setup.py install for mozsystemmonitor 19:07:47 INFO - Successfully installed mozsystemmonitor 19:07:47 INFO - Cleaning up... 19:07:47 INFO - Return code: 0 19:07:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:47 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 0x7f27ec9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c34dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc73d0>, '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 0x1c32ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', '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 19:07:47 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 19:07:47 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 19:07:47 INFO - Using env: {'DISPLAY': ':0', 19:07:47 INFO - 'HOME': '/home/cltbld', 19:07:47 INFO - 'LANG': 'en_US.UTF-8', 19:07:47 INFO - 'LANGUAGE': 'en_US:en', 19:07:47 INFO - 'LOGNAME': 'cltbld', 19:07:47 INFO - 'MAIL': '/var/mail/cltbld', 19:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:47 INFO - 'MOZ_NO_REMOTE': '1', 19:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:47 INFO - 'NO_EM_RESTART': '1', 19:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:47 INFO - 'PWD': '/builds/slave/test', 19:07:47 INFO - 'SHELL': '/bin/bash', 19:07:47 INFO - 'SHLVL': '1', 19:07:47 INFO - 'TERM': 'linux', 19:07:47 INFO - 'TMOUT': '86400', 19:07:47 INFO - 'USER': 'cltbld', 19:07:47 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', 19:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:47 INFO - '_': '/tools/buildbot/bin/python'} 19:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:47 INFO - Downloading/unpacking blobuploader==1.2.4 19:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:49 INFO - Downloading blobuploader-1.2.4.tar.gz 19:07:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:07:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:07:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:50 INFO - Downloading docopt-0.6.1.tar.gz 19:07:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:07:50 INFO - Installing collected packages: blobuploader, requests, docopt 19:07:50 INFO - Running setup.py install for blobuploader 19:07:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:07:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:07:50 INFO - Running setup.py install for requests 19:07:50 INFO - Running setup.py install for docopt 19:07:50 INFO - Successfully installed blobuploader requests docopt 19:07:50 INFO - Cleaning up... 19:07:50 INFO - Return code: 0 19:07:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:50 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')]} 19:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:50 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')]} 19:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:50 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 0x7f27ec9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c34dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc73d0>, '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 0x1c32ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', '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 19:07:50 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 19:07:50 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 19:07:50 INFO - Using env: {'DISPLAY': ':0', 19:07:50 INFO - 'HOME': '/home/cltbld', 19:07:50 INFO - 'LANG': 'en_US.UTF-8', 19:07:50 INFO - 'LANGUAGE': 'en_US:en', 19:07:50 INFO - 'LOGNAME': 'cltbld', 19:07:50 INFO - 'MAIL': '/var/mail/cltbld', 19:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:50 INFO - 'MOZ_NO_REMOTE': '1', 19:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:50 INFO - 'NO_EM_RESTART': '1', 19:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:50 INFO - 'PWD': '/builds/slave/test', 19:07:50 INFO - 'SHELL': '/bin/bash', 19:07:50 INFO - 'SHLVL': '1', 19:07:50 INFO - 'TERM': 'linux', 19:07:50 INFO - 'TMOUT': '86400', 19:07:50 INFO - 'USER': 'cltbld', 19:07:50 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', 19:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:50 INFO - '_': '/tools/buildbot/bin/python'} 19:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:07:50 INFO - Running setup.py (path:/tmp/pip-q6B5O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:07:51 INFO - Running setup.py (path:/tmp/pip-ABZtet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:07:51 INFO - Running setup.py (path:/tmp/pip-po6mKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:07:51 INFO - Running setup.py (path:/tmp/pip-iKEQCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:07:51 INFO - Running setup.py (path:/tmp/pip-DiyXQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:07:51 INFO - Running setup.py (path:/tmp/pip-KoFovk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:07:51 INFO - Running setup.py (path:/tmp/pip-ne5FV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:07:51 INFO - Running setup.py (path:/tmp/pip-MBsq0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:07:51 INFO - Running setup.py (path:/tmp/pip-2BBAil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:07:51 INFO - Running setup.py (path:/tmp/pip-Agikdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:07:51 INFO - Running setup.py (path:/tmp/pip-vw65cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:07:51 INFO - Running setup.py (path:/tmp/pip-X_perF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:07:51 INFO - Running setup.py (path:/tmp/pip-9I9XKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:07:51 INFO - Running setup.py (path:/tmp/pip-9yi45l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:51 INFO - Running setup.py (path:/tmp/pip-WoVJt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:07:52 INFO - Running setup.py (path:/tmp/pip-GeTvXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:07:52 INFO - Running setup.py (path:/tmp/pip-lSTqsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:07:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:07:52 INFO - Running setup.py install for manifestparser 19:07:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:07:52 INFO - Running setup.py install for mozcrash 19:07:52 INFO - Running setup.py install for mozdebug 19:07:52 INFO - Running setup.py install for mozdevice 19:07:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:07:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:07:52 INFO - Running setup.py install for mozfile 19:07:52 INFO - Running setup.py install for mozhttpd 19:07:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:07:52 INFO - Running setup.py install for mozinfo 19:07:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:07:52 INFO - Running setup.py install for mozInstall 19:07:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:07:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:07:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:07:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:07:53 INFO - Running setup.py install for mozleak 19:07:53 INFO - Running setup.py install for mozlog 19:07:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:07:53 INFO - Running setup.py install for moznetwork 19:07:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:07:53 INFO - Running setup.py install for mozprocess 19:07:53 INFO - Running setup.py install for mozprofile 19:07:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:07:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:07:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:07:53 INFO - Running setup.py install for mozrunner 19:07:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:07:53 INFO - Running setup.py install for mozscreenshot 19:07:53 INFO - Running setup.py install for moztest 19:07:53 INFO - Running setup.py install for mozversion 19:07:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:07:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:07:53 INFO - Cleaning up... 19:07:53 INFO - Return code: 0 19:07:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:53 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 0x7f27ec9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c34dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc73d0>, '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 0x1c32ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', '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 19:07:53 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 19:07:53 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 19:07:53 INFO - Using env: {'DISPLAY': ':0', 19:07:53 INFO - 'HOME': '/home/cltbld', 19:07:53 INFO - 'LANG': 'en_US.UTF-8', 19:07:53 INFO - 'LANGUAGE': 'en_US:en', 19:07:53 INFO - 'LOGNAME': 'cltbld', 19:07:53 INFO - 'MAIL': '/var/mail/cltbld', 19:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:53 INFO - 'MOZ_NO_REMOTE': '1', 19:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:53 INFO - 'NO_EM_RESTART': '1', 19:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:53 INFO - 'PWD': '/builds/slave/test', 19:07:53 INFO - 'SHELL': '/bin/bash', 19:07:53 INFO - 'SHLVL': '1', 19:07:53 INFO - 'TERM': 'linux', 19:07:53 INFO - 'TMOUT': '86400', 19:07:53 INFO - 'USER': 'cltbld', 19:07:53 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', 19:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:53 INFO - '_': '/tools/buildbot/bin/python'} 19:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:07:54 INFO - Running setup.py (path:/tmp/pip-6VG2PP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:07:54 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)) 19:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:07:54 INFO - Running setup.py (path:/tmp/pip-qTxsAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:07:54 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)) 19:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:07:54 INFO - Running setup.py (path:/tmp/pip-GFNcQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:07:54 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)) 19:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:07:54 INFO - Running setup.py (path:/tmp/pip-0VSK0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:07:54 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)) 19:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:07:54 INFO - Running setup.py (path:/tmp/pip-VFWrG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:07:54 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)) 19:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:07:54 INFO - Running setup.py (path:/tmp/pip-wzU0rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:07:54 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)) 19:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:07:54 INFO - Running setup.py (path:/tmp/pip-_gvQEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:07:54 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)) 19:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:07:54 INFO - Running setup.py (path:/tmp/pip-ubVID4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:07:54 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)) 19:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:07:54 INFO - Running setup.py (path:/tmp/pip-Y9Lc7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:07:54 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)) 19:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:07:54 INFO - Running setup.py (path:/tmp/pip-zeOBxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:07:54 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)) 19:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:07:54 INFO - Running setup.py (path:/tmp/pip-a7uCzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:07:55 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)) 19:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:07:55 INFO - Running setup.py (path:/tmp/pip-DrsqqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:07:55 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)) 19:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:07:55 INFO - Running setup.py (path:/tmp/pip-YaiDwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:07:55 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)) 19:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:07:55 INFO - Running setup.py (path:/tmp/pip-v7cPbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:07:55 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)) 19:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:55 INFO - Running setup.py (path:/tmp/pip-Yl8BDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:07:55 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)) 19:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:07:55 INFO - Running setup.py (path:/tmp/pip-1ELnES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:07:55 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)) 19:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:07:55 INFO - Running setup.py (path:/tmp/pip-tO_3q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:07:55 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)) 19:07:55 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)) 19:07:55 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)) 19:07:55 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)) 19:07:55 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)) 19:07:55 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)) 19:07:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:57 INFO - Downloading blessings-1.5.1.tar.gz 19:07:57 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 19:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:07:57 INFO - Installing collected packages: blessings 19:07:57 INFO - Running setup.py install for blessings 19:07:57 INFO - Successfully installed blessings 19:07:57 INFO - Cleaning up... 19:07:57 INFO - Return code: 0 19:07:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:07:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:07:57 INFO - Reading from file tmpfile_stdout 19:07:57 INFO - Current package versions: 19:07:57 INFO - argparse == 1.2.1 19:07:57 INFO - blessings == 1.5.1 19:07:57 INFO - blobuploader == 1.2.4 19:07:57 INFO - docopt == 0.6.1 19:07:57 INFO - manifestparser == 1.1 19:07:57 INFO - mozInstall == 1.12 19:07:57 INFO - mozcrash == 0.16 19:07:57 INFO - mozdebug == 0.1 19:07:57 INFO - mozdevice == 0.47 19:07:57 INFO - mozfile == 1.2 19:07:57 INFO - mozhttpd == 0.7 19:07:57 INFO - mozinfo == 0.9 19:07:57 INFO - mozleak == 0.1 19:07:57 INFO - mozlog == 3.1 19:07:57 INFO - moznetwork == 0.27 19:07:57 INFO - mozprocess == 0.22 19:07:57 INFO - mozprofile == 0.28 19:07:57 INFO - mozrunner == 6.11 19:07:57 INFO - mozscreenshot == 0.1 19:07:57 INFO - mozsystemmonitor == 0.0 19:07:57 INFO - moztest == 0.7 19:07:57 INFO - mozversion == 1.4 19:07:57 INFO - psutil == 3.1.1 19:07:57 INFO - requests == 1.2.3 19:07:57 INFO - wsgiref == 0.1.2 19:07:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f27ec9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c34dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc73d0>, '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 0x1c32ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', '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 19:07:57 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 19:07:57 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 19:07:57 INFO - Using env: {'DISPLAY': ':0', 19:07:57 INFO - 'HOME': '/home/cltbld', 19:07:57 INFO - 'LANG': 'en_US.UTF-8', 19:07:57 INFO - 'LANGUAGE': 'en_US:en', 19:07:57 INFO - 'LOGNAME': 'cltbld', 19:07:57 INFO - 'MAIL': '/var/mail/cltbld', 19:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:57 INFO - 'MOZ_NO_REMOTE': '1', 19:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:57 INFO - 'NO_EM_RESTART': '1', 19:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:57 INFO - 'PWD': '/builds/slave/test', 19:07:57 INFO - 'SHELL': '/bin/bash', 19:07:57 INFO - 'SHLVL': '1', 19:07:57 INFO - 'TERM': 'linux', 19:07:57 INFO - 'TMOUT': '86400', 19:07:57 INFO - 'USER': 'cltbld', 19:07:57 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', 19:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:57 INFO - '_': '/tools/buildbot/bin/python'} 19:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:57 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)) 19:07:57 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)) 19:07:57 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)) 19:07:57 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)) 19:07:57 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)) 19:07:57 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)) 19:07:57 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)) 19:07:57 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)) 19:07:57 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)) 19:07:57 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)) 19:07:57 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)) 19:07:57 INFO - Cleaning up... 19:07:57 INFO - Return code: 0 19:07:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f27ec9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c34dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc73d0>, '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 0x1c32ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', '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 19:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:07:57 INFO - Using env: {'DISPLAY': ':0', 19:07:57 INFO - 'HOME': '/home/cltbld', 19:07:57 INFO - 'LANG': 'en_US.UTF-8', 19:07:57 INFO - 'LANGUAGE': 'en_US:en', 19:07:57 INFO - 'LOGNAME': 'cltbld', 19:07:57 INFO - 'MAIL': '/var/mail/cltbld', 19:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:57 INFO - 'MOZ_NO_REMOTE': '1', 19:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:57 INFO - 'NO_EM_RESTART': '1', 19:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:57 INFO - 'PWD': '/builds/slave/test', 19:07:57 INFO - 'SHELL': '/bin/bash', 19:07:57 INFO - 'SHLVL': '1', 19:07:57 INFO - 'TERM': 'linux', 19:07:57 INFO - 'TMOUT': '86400', 19:07:57 INFO - 'USER': 'cltbld', 19:07:57 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', 19:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:57 INFO - '_': '/tools/buildbot/bin/python'} 19:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:57 INFO - Downloading/unpacking jsonschema 19:07:58 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 19:07:58 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 19:07:58 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 19:07:58 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 19:07:58 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 19:07:58 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 19:07:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:07:59 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 19:07:59 INFO - Downloading/unpacking functools32 (from jsonschema) 19:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:59 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:00 INFO - warning: no files found matching '*.txt' 19:08:00 INFO - no previously-included directories found matching 'build' 19:08:00 INFO - no previously-included directories found matching 'dist' 19:08:00 INFO - no previously-included directories found matching '.git*' 19:08:00 INFO - Installing collected packages: jsonschema, functools32 19:08:00 INFO - Running setup.py install for functools32 19:08:00 INFO - warning: no files found matching '*.txt' 19:08:00 INFO - no previously-included directories found matching 'build' 19:08:00 INFO - no previously-included directories found matching 'dist' 19:08:00 INFO - no previously-included directories found matching '.git*' 19:08:00 INFO - Successfully installed jsonschema functools32 19:08:00 INFO - Cleaning up... 19:08:00 INFO - Return code: 0 19:08:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:00 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 0x7f27ec9a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c34dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc73d0>, '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 0x1c32ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33360>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', '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 19:08:00 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 19:08:00 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 19:08:00 INFO - Using env: {'DISPLAY': ':0', 19:08:00 INFO - 'HOME': '/home/cltbld', 19:08:00 INFO - 'LANG': 'en_US.UTF-8', 19:08:00 INFO - 'LANGUAGE': 'en_US:en', 19:08:00 INFO - 'LOGNAME': 'cltbld', 19:08:00 INFO - 'MAIL': '/var/mail/cltbld', 19:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:00 INFO - 'MOZ_NO_REMOTE': '1', 19:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:00 INFO - 'NO_EM_RESTART': '1', 19:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:00 INFO - 'PWD': '/builds/slave/test', 19:08:00 INFO - 'SHELL': '/bin/bash', 19:08:00 INFO - 'SHLVL': '1', 19:08:00 INFO - 'TERM': 'linux', 19:08:00 INFO - 'TMOUT': '86400', 19:08:00 INFO - 'USER': 'cltbld', 19:08:00 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', 19:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:00 INFO - '_': '/tools/buildbot/bin/python'} 19:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:00 INFO - Downloading/unpacking flake8 19:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:08:02 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 19:08:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:08:02 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 19:08:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:02 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 19:08:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:08:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:02 INFO - no previously-included directories found matching 'docs/_build' 19:08:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:08:02 INFO - Running setup.py install for pep8 19:08:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:02 INFO - no previously-included directories found matching 'docs/_build' 19:08:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:08:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:08:03 INFO - Cleaning up... 19:08:03 INFO - Return code: 0 19:08:03 INFO - Running post-action listener: _resource_record_post_action 19:08:03 INFO - Running post-action listener: _start_resource_monitoring 19:08:03 INFO - Starting resource monitoring. 19:08:03 INFO - ##### 19:08:03 INFO - ##### Running install step. 19:08:03 INFO - ##### 19:08:03 INFO - Running pre-action listener: _resource_record_pre_action 19:08:03 INFO - Running main action method: install 19:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:03 INFO - Reading from file tmpfile_stdout 19:08:03 INFO - Detecting whether we're running mozinstall >=1.0... 19:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:08:03 INFO - Reading from file tmpfile_stdout 19:08:03 INFO - Output received: 19:08:03 INFO - Usage: mozinstall [options] installer 19:08:03 INFO - Options: 19:08:03 INFO - -h, --help show this help message and exit 19:08:03 INFO - -d DEST, --destination=DEST 19:08:03 INFO - Directory to install application into. [default: 19:08:03 INFO - "/builds/slave/test"] 19:08:03 INFO - --app=APP Application being installed. [default: firefox] 19:08:03 INFO - mkdir: /builds/slave/test/build/application 19:08:03 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'] 19:08:03 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 19:08:18 INFO - Reading from file tmpfile_stdout 19:08:18 INFO - Output received: 19:08:18 INFO - /builds/slave/test/build/application/firefox/firefox 19:08:18 INFO - Running post-action listener: _resource_record_post_action 19:08:18 INFO - ##### 19:08:18 INFO - ##### Running run-tests step. 19:08:18 INFO - ##### 19:08:18 INFO - Running pre-action listener: _resource_record_pre_action 19:08:18 INFO - Running main action method: run_tests 19:08:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:08:18 INFO - Python 2.7.3 19:08:18 INFO - Return code: 0 19:08:18 INFO - grabbing minidump binary from tooltool 19:08: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')]} 19:08:18 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 0x1cc73d0>, '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 0x1c32ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c33360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:08:18 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 19:08:18 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 19:08:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:08:18 INFO - Return code: 0 19:08:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:08:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:08:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:08:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:08:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:08:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:08:19 INFO - Return code: 0 19:08:19 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/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 19:08:19 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/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 19:08:19 INFO - Using env: {'DISPLAY': ':0', 19:08:19 INFO - 'HOME': '/home/cltbld', 19:08:19 INFO - 'LANG': 'en_US.UTF-8', 19:08:19 INFO - 'LANGUAGE': 'en_US:en', 19:08:19 INFO - 'LOGNAME': 'cltbld', 19:08:19 INFO - 'MAIL': '/var/mail/cltbld', 19:08:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:08:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:19 INFO - 'MOZ_NO_REMOTE': '1', 19:08:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:19 INFO - 'NO_EM_RESTART': '1', 19:08:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:19 INFO - 'PWD': '/builds/slave/test', 19:08:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:08:19 INFO - 'SHELL': '/bin/bash', 19:08:19 INFO - 'SHLVL': '1', 19:08:19 INFO - 'TERM': 'linux', 19:08:19 INFO - 'TMOUT': '86400', 19:08:19 INFO - 'USER': 'cltbld', 19:08:19 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972', 19:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:19 INFO - '_': '/tools/buildbot/bin/python'} 19:08:19 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/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 19:08:20 INFO - mozversion application_buildid: 20151225175148 19:08:20 INFO - mozversion application_changeset: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 19:08:20 INFO - mozversion application_display_name: Nightly 19:08:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:08:20 INFO - mozversion application_name: Firefox 19:08:20 INFO - mozversion application_remotingname: firefox 19:08:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 19:08:20 INFO - mozversion application_vendor: Mozilla 19:08:20 INFO - mozversion application_version: 46.0a1 19:08:20 INFO - mozversion platform_buildid: 20151225175148 19:08:20 INFO - mozversion platform_changeset: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 19:08:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 19:08:20 INFO - mozversion platform_version: 46.0a1 19:08:20 INFO - using testdate: 1451099300 19:08:20 INFO - actual date: 1451099300 19:08:20 INFO - starting webserver on 'localhost:33777' 19:08:20 INFO - SUITE-START | Running 3 tests 19:08:20 INFO - TEST-START | dromaeo_css 19:08:20 INFO - operating with platform_type : linux_ 19:08:20 INFO - Initialising browser for dromaeo_css test... 19:08:20 INFO - TEST-INFO | started process 7485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsJ7qXR/profile http://localhost:33777/getInfo.html) 19:08:24 INFO - PROCESS | 7485 | __metrics Screen width/height:1600/1200 19:08:24 INFO - PROCESS | 7485 | colorDepth:24 19:08:24 INFO - PROCESS | 7485 | Browser inner width/height: 1024/697 19:08:24 INFO - PROCESS | 7485 | __metrics 19:08:24 INFO - PROCESS | 7485 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:08:24 INFO - PROCESS | 7485 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:08:25 INFO - TEST-INFO | 7485: exit 0 19:08:25 INFO - Browser initialized. 19:08:25 INFO - Running cycle 1/1 for dromaeo_css test... 19:08:25 INFO - TEST-INFO | started process 7576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsJ7qXR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:37 INFO - PROCESS | 7576 | RSS: Main: 148824064 19:08:37 INFO - PROCESS | 7576 | 19:09:28 INFO - PROCESS | 7576 | 1451099368554 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] 19:11:40 INFO - PROCESS | 7576 | Cycle 1(1): loaded http://localhost:33777/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33777/tests/dromaeo/cssquery-ext.html) 19:11:41 INFO - PROCESS | 7576 | RSS: Main: 252600320 19:11:41 INFO - PROCESS | 7576 | 19:14:43 INFO - PROCESS | 7576 | Cycle 1(1): loaded http://localhost:33777/tests/dromaeo/cssquery-ext.html (next: http://localhost:33777/tests/dromaeo/cssquery-jquery.html) 19:14:44 INFO - PROCESS | 7576 | RSS: Main: 227045376 19:14:44 INFO - PROCESS | 7576 | 19:17:46 INFO - PROCESS | 7576 | Cycle 1(1): loaded http://localhost:33777/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33777/tests/dromaeo/cssquery-mootools.html) 19:17:47 INFO - PROCESS | 7576 | RSS: Main: 220106752 19:17:47 INFO - PROCESS | 7576 | 19:20:49 INFO - PROCESS | 7576 | Cycle 1(1): loaded http://localhost:33777/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33777/tests/dromaeo/cssquery-prototype.html) 19:20:49 INFO - PROCESS | 7576 | RSS: Main: 210358272 19:20:49 INFO - PROCESS | 7576 | 19:23:52 INFO - PROCESS | 7576 | Cycle 1(1): loaded http://localhost:33777/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33777/tests/dromaeo/cssquery-yui.html) 19:23:53 INFO - PROCESS | 7576 | RSS: Main: 213467136 19:23:53 INFO - PROCESS | 7576 | 19:26:55 INFO - PROCESS | 7576 | Cycle 1(1): loaded http://localhost:33777/tests/dromaeo/cssquery-yui.html (next: http://localhost:33777/tests/dromaeo/cssquery-dojo.html) 19:26:55 INFO - PROCESS | 7576 | RSS: Main: 258183168 19:26:55 INFO - PROCESS | 7576 | 19:26:55 INFO - PROCESS | 7576 | __start_tp_report 19:26:55 INFO - PROCESS | 7576 | _x_x_mozilla_page_load 19:26:55 INFO - PROCESS | 7576 | _x_x_mozilla_page_load_details 19:26:55 INFO - PROCESS | 7576 | |i|pagename|runs| 19:26:55 INFO - PROCESS | 7576 | |0;dojo.html;2569.659288486352;2670.279024663342;2677.0228866463744;2683.651125353705;2691.609716591094;4423.513413524518;4529.479109902362;4555;4620.052889157723;4623.445186577607;4540.432445944257;4581.656375771814;4631.745254011028;4645.744484053375;4650.116477869203;4187.1625674865;4211.199872024321;4264.658827293817;4330.891727706801;4378.934315985262;4061.248668996245;4333.176696427684;4349.521552629209;4382.364557139229;4383.736975781448;4157.833686652531;4251.723637963553;4323.956760432387;4334.436523251957;4381.518033016366;4290.806913688892;4297.72064815786;4310.870673879788;4349.630281426083;4353.08585197109;4114.465119534471;4266.743995360288;4289.914201715948;4317.179735850178;4357.869263922087;4457.353683715875;4457.9331310030375;4525.479569849444;4590;4635.6986795858165;4922.876928076791;4931.408231012301;4932.8520144395725;4945.530174633404;4971.055499455092;4727.409073865767;4914.287428322909;4932.899875116447;4935.457099719028;4954.380702412199;4513.119941611354;4528.026474308007;4570.474395444567;4638.327442520883;4659.091477161988;5023.34696489454;5025.346704928409;5027.4469808321055;5027.547520723152;5060.49395060491;4820.927686084711;4823.083614113307;4823.397075365579;4829;4859;4661.021185551004;4753.714777113315;4765.475797662254;4766.713997160112;4910.116179087799;4892.119418504632;4951.554360107608;4956.330895329156;4957.058158949788;4991.975040124777;4887.804487820447;4910.558049775537;4919.508049195052;4928.112939670822;4964.15609346412;3935.704822138351;4042.91914161721;4114.485689288839;4159.209750147463;4178.22702799983;3580.0870777951977;3596.1009747563107;3632.3824949758605;3659.7804131751645;3662.3957047087465;4224.894377640522;4227.3447615619625;4237.322028475429;4241.554636763157;4273.893152671146;4709.552592503706;4810.302506136591;4926.433460152057;4940.505949405103;4986.925196122061;4146.606072423115;4152.169566086734;4202.474690663667;4209.24233637942;4241.575842415796;4357.346398040319;4370.628496577827;4371.082072764755;4405.074934263776;4409.14021765759;4519.254323036662;4621.445426548701;4668.11305851887;4685.695429797121;4718.764061796828;4819.108464933858;4906.730129842893;4967.478414766398;4995.275685025578;5026.974865125651;4735.83424580138;4738.763061846963;4749.691270067435;4791.976040119777;4795.232762757942;4715.575598196178;4815.446223684321;4922.286268490977;4947.678400903929;4982.825601103944;4833.419989601271;4871.975640121776;4906.705597664151;4925.261210818406;4975.0796102721115;4742.928856067231;4766.285057241442;4771.761411929459;4776.904461910812;4818.036392721539;4645.442546894395;4752.239641657318;4777.259524773665;4777.713337199779;4820.204666230173;4551.726896386227;4638.188317044571;4672.08894265615;4705.76471176433;4715.575598196178;4797.592204662643;4805.423349198119;4805.495422980537;4806.6875653083835;4864.027194561031;4518.254488009573;4703.412073490814;4704.92942605868;4710.505396933273;4710.9764451177525 19:26:55 INFO - PROCESS | 7576 | |1;ext.html;534.3774502704347;547.3158551810237;548.8448457839803;575.0425541473446;588.9882202355953;23710.644340334886;24186.395340116484;33006.33987320255;33453;33497.33005339892;35932;36372.636273637254;36472.81763591185;36480.81759591205;36492.270154596896;6702.631355275458;6757.425618822382;7565.62171891406;7719.189485104067;7728.652210650506;9800.068993445648;10013.749656258578;10015.699529014104;10018.298719089667;10024.19806415485;9626.518674066268;9715.854262186072;9731.464769437678;9743.658971935984;9761.170300524429;6899.655017249117;7062.223155452896;9665.46839923804;9836.262280329003;10031.89968100317;9442.150206481381;9530.90469095314;9537.666181683608;9540.189083927875;9541.904580954171;32185.83907080473;32557.51163732546;32558.18604534882;32571.674283257336;32576.67423325784;2773.4715749071684;2882.2938380096803;2899.1882272963603;2900.8114472559214;3371.6291207967106;27541.586876196874;27918.581221281696;27957.86021069902;28033;28055.29861753452;3369.126980958841;3435.5362026126404;3438.8796392126155;3516.5604299462566;3549.6450354964554;162394;163739;163795;163979;164468.17765911095;43403;54264.186037209474;54359.18461223085;54373.72813135909;54613.45386546083;37461.62538374636;57104.42895570991;58009.709951450815;58572.414275856696;58625.41374586285;11864;12023.338716370508;12077.879221207852;12084.395780210954;12127.939360303142;9736.318457708034;9772.16936560386;9802.509874506246;9846.261530385107;9852.359596626196;17645;17753.822461775217;17754.37859674905;17824.732629010574;18558.164882580317;6875.209350924708;7519.323260906544;7549.245075492407;7572.318491335806;7575.280348366897;786.3669745854642;852.3692467573951;870.4037734152126;875.5490922175085;1043.087298613713;22107;22239.742911605787;22473;25948;26711.599326010124;895.8387490251687;926.249737712455;928.2805825485168;950.695777351241;997.3915911294105;12637.368131593568;13872.237026963412;14503.564893053226;14709.852901471062;14731.337089830984;196161;199140;199357;199651;199717;40613;40626;40805.1838963225;40812.38781418281;40957;1164.7262893220086;1177.8704342522315;1181.7931861924128;1196.6529706385052;1200.3878022208562;22047.889760551094;25696.357591060372;25926.35184120412;26739.197824065308;26912.730872691805;35852;36097.097572560895;36124.45813312855;36140.4578931311;36174;167493;168926;168948;169003.1549842243;169324.15337923725;23053.423664408525;27691.169264922086;30607.234819128807;30991.535126973566;31089;34583.82708086444;35002.29995400027;35675.46486802648;35783.284334312644;35808;30260.394792103594;30382.392352153274;30489;31434.59915611862;31574.684253158095;31144.844275778476;31233.219169520944;31466;31563.684363156994;31619.051428457184;30213.395732084795;30919;31174.68825311718;31175.376492470477;31232;26581.734182657925;28204.71795282103;29304.26739331534;29503.114906552837;32451;21090.156393744077;22004.559908802054;22643.547129057657;22787.88606056959;22809.657855131853 19:26:55 INFO - PROCESS | 7576 | |2;jquery.html;324.93338865532576;329.965353637868;331.2712033526243;331.8683289981164;336.71547542326726;11775.587854425097;12206.084543659217;14519.49181778638;15019.32413041413;15580.84419155808;12359.073069519776;15004.924975375108;15978.201089945514;16620.418285360014;16621.750673739873;4850.46644869065;4987.077390682717;5042.899142017158;5212.76542555584;5217.426083130871;3427.091820667525;3531.0113168312914;5152.896942061157;5179.974100129494;5180.766865491062;5014.623903207255;5135.460776618457;5159.871003224931;5173.793048278064;5174.197999310113;5120.615953803443;5137.998090372379;5150.459201783815;5485.725713714299;5872.236609240814;5163.277141200235;5167.638265321429;5172.689638621657;5174.870628234286;5190.143626301656;17378.565535861577;17654.205560749797;18085.186166622534;18802.435926922215;19330;1773.1045821860007;1786.553361659585;1792.6952418088956;1811.7191835265423;1819.6815557277423;8897.288216942694;8913.28693704502;9176.03651616584;9182.173604375572;9191.172794448465;1698.524413164316;1728.3086765293858;1737.7654016707709;1757.7187649975942;1764.5765016396101;52832.73583632057;53697.46302536964;54902;57691.71154144244;57913.420865791224;9829.508524573743;9908.20734341251;9918.15695665862;9944.701658950244;10046.899531004596;12635.87364126347;12638.178518396275;12641.11512194156;12651.620451386472;12658.81011784824;6825.419839313615;6865.382115609519;6896.620685862325;6933.1333583302085;6946.097007389007;6583.539152259296;6587.769428069994;6603.669816509156;6692.297308782605;6715.328467153246;4188.32986722123;4244.511881133709;4253.659707223414;4282.571742825755;4290.570942905684;1587.2539906244047;1678.2531773360981;1724.8016478104928;1742.9651406972043;1750.422360620992;753.9698412063566;794.9602519873984;854.6666799948025;861.1431625532636;967.9177269931994;15298.235088245543;15435.691286174439;15786.921065394828;15809.367625294859;15883.364665413254;712.9465290103263;806.4234072638092;815.3069890593067;843.0389356134012;848.3001523742813;7848.882266766003;7935.563544005136;8240.21717936795;8247.422680412434;8331.95850518685;484670;485910;486692;519379;538583;34936;35019;45893.77053114713;66319.33680663229;68414.3158568408;1025.5077562769764;1026.97432564185;1030.9587616495405;1076.1659713721929;1091.5306418240234;13033.608991730263;13531.391087400894;14221.502247421291;14228;14311.856881431053;29673.258168545097;29936.850315749154;30014.69985300119;30375.392492149593;31151.53272700866;36516.45225321569;37221.44167837431;37248.81375593105;38380;38569.228615428096;8264.710735124241;8385.83228335442;8633.91366086331;8684.088170742234;8693.956530217309;15173.696526069638;15427.228638568251;15435.459758908384;15739.763903541227;15752.133632650315;13827.861721382658;13853.16880987144;13879.514217002357;13908.791368129689;14262.144271343752;12622.747545049231;12800.86378837191;13212.669683257995;13474.19154850712;13700.109492882932;10148.847767283349;11668.358240296866;14119.152850828983;14299.35652895643;14430.567082987527;8493.787655308666;8494.088830013197;8497.787555311166;8504.362172837185;8513.914860851311;13054.804177937149;13058.21650700961;13281.933590331986;13355.465781368637;13377.398017089059 19:26:55 INFO - PROCESS | 7576 | |3;mootools.html;1153.3771763247846;1357.3688234970737;1360.897932655051;1467.2370367408948;1727.3608764757034;5747.971260143699;5874.3244526879425;6915.204751453584;7013.088298521197;7028.648567571614;6771.8984215236815;6813.046173535709;6848.794536163923;6859.279775623562;6868;1616.0707593133936;1645.3336398758463;2016.0524553459886;2042.1627132875524;2045;2035.8269547088514;2075.169932027186;2076.0346438905904;2079.189116244666;2081.1259271106096;1954.4039068084228;1957.4340527577951;1963.8919859407727;2000.5898790747863;2003.459066052165;1964.3812199157219;1978.6042791441698;1998.670219413795;2000.5898790747863;2001.0495014867968;2005.8896760678158;2027.6147531969027;2029.249177804222;2040.3878836349036;2041.1529215375601;6974.721011159548;7051.612161331124;7053.89419158713;7054.118235220598;7059.611721355323;4115.053537686349;4190.580941905816;4203.117345357478;4211.157768446323;4226.619604235603;2664.1607893513483;2700.419409826877;2765.8893644254204;2785.874635641381;2793.5530315149476;809.1140201479429;834.1491678487969;847.3179090831878;848.0586548930683;860.7460799064291;9450.243980481613;9451.574679139387;9457.33798634096;9463.952680236554;9465.053494650549;3726.571444283942;3780.1305699689224;3854.402567602026;3879.049632839972;3884.7280690351968;8167.0199576051255;8176.836463270702;8189.50862948225;8193.50838949653;8194.590270486571;4289.1850548395705;4292.077203401283;4296.355546667963;4298.032942587893;4304.48346198452;3874.9612503875164;3900.473436086149;3904.6095390460728;3908.6677632401565;3910.022494376406;2872.5116730155924;2909.796314258024;3344.2475443025123;3375.8649654014057;3427.9485807712904;1044.9059584637419;1045.6601604478574;1062.7024433158729;1062.8193207154802;1065.872095348563;859.7936495241097;914.721010091915;926.4487629860222;927.8005228875824;939.7603611079131;6692.163479565054;6771.695273712695;6776.15298087739;6788.8302792429595;6792;1004.2217281606813;1027.671145233518;1030.953607087683;1031.1905154453868;1050.3907733514543;5050;5147.382314122255;5154.072266991902;5158.664686795346;5160.174372100446;8056.274935255855;8119.106898241189;8203.548804815793;8324.70863519786;8339.791505212297;8185.181481851767;8217.055038670629;8236.629351679188;8266.669333226604;8278.793030174294;6556.3443655634055;6632.1046658701425;6683.933160668428;6696.330366963265;6697.732090716317;6234.314225435108;6288.465480434214;6312.084747711464;6324.841878953063;6335.334789847184;7340.596267205141;7496.362809161283;7539.698412063456;7562.130355009024;7587.886181707389;7471.626418678936;7555.546667199986;7618;7676.462647614613;7798.883016754639;6116.969415152896;6176.197094377702;6178.969105154445;6183.319834818257;6183.350748171377;5676.7161641918565;6461.903071453838;6571;6661.866762664623;6677.2988836173445;6214.223222097238;6249.7187626557825;6333.841653958688;6382.68086595659;6473.029045643191;5965.612235204698;6112.235970503687;6147.754089836357;6275.215598050244;6311.873762524632;6202.627842329474;6216.222972128484;6266.248050234001;6416.51876109303;6418.903716444351;5857.092150716646;5860.38465961068;5872.706364681834;5877.089051197071;5906.793262235801;5988.520918326611;5989.52083833301;6045.879082418415;6051.334353221054;6058.878822423439 19:26:55 INFO - PROCESS | 7576 | |4;prototype.html;287.31332116242186;298.2885817325678;298.4746845551828;308.092667095404;310.6924145096352;5340.866478338044;5399.730013499329;5437.755301011454;5504.504594586487;5553.361363443195;5248.265242865992;5400.459954004597;5400.540954018913;5401.567874570025;5422.48486393792;4187.413762073312;4191.287481128208;4191.664666826647;4192.140611174702;4201.075763332062;3946.3093958557283;4052.128792309653;4072.0430698785763;4149.128682976579;4165.500139983206;4109.938350924738;4110.157417729373;4115.8971025724295;4118.588141185887;4130.463039804821;4108.856190033334;4110.403991421257;4111.732737372061;4111.835526578948;4132.380142978547;3584.426491761332;3586.2110335726097;3589.246258285763;3590.6768390844686;3591.299696559172;5116.69299842007;5245.606579506514;5245.816396426107;5258.894822103574;5283.339582552181;4755.405574303212;4768.904621907543;4774.092922344744;4774.188387974018;4780.091782561302;5728.283964504437;5741.110127930177;5745.626534275259;5755.740991655385;5755.971220143872;3712.3317802795486;3817.866374676873;3820.541535015788;3898.571157172709;3908.7850168240734;5873.442023007808;5913.2608423947;5938.6436813791315;6016.097585362187;6020.488258497989;3994.720369574102;4004.4593979812935;4007.358822588372;4007.358822588372;4015.658669013108;4065.3495440729343;4065.5527891931865;4071.776052317151;4077.55146933837;4081.5102187737066;4591.1965406053805;4687.6249900007915;4711;4741.739204343725;4753.904921901542;5679.545636349082;5680.687562184037;5688.971555142198;5692.402297758758;5710.628809127394;1420.6732451536204;1449.3622805965342;1450.557579938129;1451.165579791624;1451.5282533176548;953.7949340891741;962.932594718377;964.2575217082807;965.9517024148764;966.0725703324887;4968.950310496921;4976.2286845539;4979.975100124549;4983.825566105169;4987.600991920638;5937.910931336033;5941.435563621449;5942.7920022799;5943.64338139713;5949.881002379928;4961.231009193581;4970.975145124251;4980.950190498121;4990.176620857518;4991.401031876198;3129.8278594677513;3174.873005079771;3180.904572862818;3205.6313523944577;3215.903522894317;5632.633878797865;5633.605647604711;5645.068563687028;5648.6893220872425;5649.12438572022;6082.087686847009;6123.601965872204;6123.632582045091;6133.815985520441;6144.078388241799;5610.635308704921;5619.690916999522;5623.493885550321;5627.690477023639;5631.802886898939;5804.332501762351;5954.3152537458745;5999.190109335358;6002.279726432856;6004.369541198286;5599.272094627672;5661.858453538694;5752;5806.912896306643;5851.444112809277;5645.491905728504;5659.405762395054;5663.263775709132;5674.063779476505;5674.631148975303;4017.879463615979;4073.0224746061326;4078.0620457294394;4078.775667338325;4086.40747091676;5830.47525722687;5991;5991.161237426677;5998;5999.670018149044;5791.420857914175;5792.4497172768515;5805.129230615442;5811.854703632443;5815.680137592304;5803.303603567599;5805.216295800182;5806.274215723035;5809.477147056617;5811.506021988178;5650.434956504317;5654.547636189012;5662.037453632975;5664.49019588239;5665;5625.803096891589;5826.883462330645;5832.212651292191;5834.358220595646;5835;5672.262605861211;5678.829635110953;5680.801171958961;5681;5685.431456854281 19:26:55 INFO - PROCESS | 7576 | |5;yui.html;635.7806556737927;698.9585517578809;742.4913933955245;766.8197973476232;774.2219069834815;11078.279911805726;11156.721081972955;11194.664160075201;11204.103671706263;11246.662600121988;10065.899341006587;10825.621103261388;11218.158638102133;11306.095512359012;11316.547338106466;769.7075111457652;781.2109769133159;786.5634572812087;786.7639708087579;787.1538096546207;776.1617453150612;784.5449639209273;786.6145588661572;786.8622990976556;787.3465024030041;814.539785021461;822.8189798244376;822.8642274024779;822.9053658829251;824.056455358614;819.7499762572413;820.151143566406;820.8112134209106;820.9014918209823;821.7822277096574;603.8882806680734;606.6754286456725;606.8816580766752;607.1287702147432;607.3531688751509;9666.903330966741;9784.364016338986;9801.852972205423;9815.067568581046;9824.656137035241;9163.908360916439;9326.347155699104;9396.29527785412;9554.9522252389;9645.614175432975;8238.299744521662;8246.340292776624;8263.95868020656;8273.296769774577;8285.54429506383;2818.3658676797763;3102.58036386699;3117.688231176887;3124.375124975014;3141.0576826951824;33829.830850845836;37301.44047839285;38424.423633645514;43028;43036.354454683205;9356.34505584616;9441.622335106518;9464.858027129598;9473.194778443773;9552.092551207625;17063.573410664834;17089.316427343016;17100.74348884768;17116.91441542809;17138.40015599448;6260.68696565179;6439.80680579574;6460.418562329319;6557.868842623121;6683.665816709243;3517.1031386996665;3567.982160089183;3572.142685755452;3627.2564124354444;3639.7998110103667;2617.633531305619;2651.7613414792763;2657.4419371932113;2659.614355918381;2661.6672915885515;479.5971384037425;508.1767536590747;520.570529313318;522.1071966936581;524.4336116993637;443.54758146690193;569.5159114752428;582.1384351160222;589.711041589618;619.4239357397663;6893.216950893061;7006.75476358325;7027.8243043923285;7100;7155.356017958408;567.7076305702567;571.7712914834017;594.3195041677255;600.4835841176584;605.7032054293364;3286.819224942651;3461.376952148587;3549.290141971616;4041.2927737645796;4153.190127925086;46095.539044609795;46295.30557041647;46352.304715429294;46756.766216168704;46898.062038759716;42208.788956055025;42874.35688464675;42917.35623965643;43512.56487435085;44619.77690111593;39962.80018599889;40266;40658.59341406548;40925.795371022956;41115.383269250386;7855.921440785519;8146.959265203636;8379.83240335202;8420.87368689458;8558.486490810572;30098.69901300959;30950;31235;31326.530102048942;31424.371512570076;37551.624483754815;38283.61716382801;41193.794031029654;41279.1744165109;41401.585984139776;10148.79702405933;10330.328528645614;10344.896551034695;10378.584856605652;10526;11030.889691103308;11046.392448415414;11067.72330691739;11085.168612353944;11452.599159029394;9679.370840895319;9742.95128524353;9766.169875560658;9814.558344874355;10191.235657325878;10086.394816311045;10295.610092637398;10316.587336506456;10363.63727269542;10369.688909332732;10691.465426728788;10903.236773425784;11062.944685276843;11359.716007099889;11362.261453005529;9143.451392916446;9165.725028249164;9383.953080234554;9402.482863442576;9570.425774453555;8453.44177979778;8469.661213551635;8515.148485151436;8558.57207139628;8592.484450932963 19:26:55 INFO - PROCESS | 7576 | __end_tp_report 19:26:55 INFO - PROCESS | 7576 | __start_cc_report 19:26:55 INFO - PROCESS | 7576 | _x_x_mozilla_cycle_collect,970 19:26:55 INFO - PROCESS | 7576 | __end_cc_report 19:26:55 INFO - PROCESS | 7576 | __startTimestamp1451100415726__endTimestamp 19:26:55 INFO - PROCESS | 7576 | 19:26:55 INFO - PROCESS | 7576 | ------- Summary: start ------- 19:26:55 INFO - PROCESS | 7576 | Number of tests: 6 19:26:55 INFO - PROCESS | 7576 | 19:26:55 INFO - PROCESS | 7576 | [#0] dojo.html Cycles:165 Average:4543.36 Median:4668.11 stddev:462.88 (9.9%) stddev-sans-first:437.63 19:26:55 INFO - PROCESS | 7576 | Values: 2569.7 2670.3 2677.0 2683.7 2691.6 4423.5 4529.5 4555.0 4620.1 4623.4 4540.4 4581.7 4631.7 4645.7 4650.1 4187.2 4211.2 4264.7 4330.9 4378.9 4061.2 4333.2 4349.5 4382.4 4383.7 4157.8 4251.7 4324.0 4334.4 4381.5 4290.8 4297.7 4310.9 4349.6 4353.1 4114.5 4266.7 4289.9 4317.2 4357.9 4457.4 4457.9 4525.5 4590.0 4635.7 4922.9 4931.4 4932.9 4945.5 4971.1 4727.4 4914.3 4932.9 4935.5 4954.4 4513.1 4528.0 4570.5 4638.3 4659.1 5023.3 5025.3 5027.4 5027.5 5060.5 4820.9 4823.1 4823.4 4829.0 4859.0 4661.0 4753.7 4765.5 4766.7 4910.1 4892.1 4951.6 4956.3 4957.1 4992.0 4887.8 4910.6 4919.5 4928.1 4964.2 3935.7 4042.9 4114.5 4159.2 4178.2 3580.1 3596.1 3632.4 3659.8 3662.4 4224.9 4227.3 4237.3 4241.6 4273.9 4709.6 4810.3 4926.4 4940.5 4986.9 4146.6 4152.2 4202.5 4209.2 4241.6 4357.3 4370.6 4371.1 4405.1 4409.1 4519.3 4621.4 4668.1 4685.7 4718.8 4819.1 4906.7 4967.5 4995.3 5027.0 4735.8 4738.8 4749.7 4792.0 4795.2 4715.6 4815.4 4922.3 4947.7 4982.8 4833.4 4872.0 4906.7 4925.3 4975.1 4742.9 4766.3 4771.8 4776.9 4818.0 4645.4 4752.2 4777.3 4777.7 4820.2 4551.7 4638.2 4672.1 4705.8 4715.6 4797.6 4805.4 4805.5 4806.7 4864.0 4518.3 4703.4 4704.9 4710.5 4711.0 19:26:55 INFO - PROCESS | 7576 | 19:26:55 INFO - PROCESS | 7576 | [#1] ext.html Cycles:180 Average:33751.42 Median:31902.45 stddev:45871.73 (143.8%) stddev-sans-first:45932.60 19:26:55 INFO - PROCESS | 7576 | Values: 534.4 547.3 548.8 575.0 589.0 23710.6 24186.4 33006.3 33453.0 33497.3 35932.0 36372.6 36472.8 36480.8 36492.3 6702.6 6757.4 7565.6 7719.2 7728.7 9800.1 10013.7 10015.7 10018.3 10024.2 9626.5 9715.9 9731.5 9743.7 9761.2 6899.7 7062.2 9665.5 9836.3 10031.9 9442.2 9530.9 9537.7 9540.2 9541.9 32185.8 32557.5 32558.2 32571.7 32576.7 2773.5 2882.3 2899.2 2900.8 3371.6 27541.6 27918.6 27957.9 28033.0 28055.3 3369.1 3435.5 3438.9 3516.6 3549.6 162394.0 163739.0 163795.0 163979.0 164468.2 43403.0 54264.2 54359.2 54373.7 54613.5 37461.6 57104.4 58009.7 58572.4 58625.4 11864.0 12023.3 12077.9 12084.4 12127.9 9736.3 9772.2 9802.5 9846.3 9852.4 17645.0 17753.8 17754.4 17824.7 18558.2 6875.2 7519.3 7549.2 7572.3 7575.3 786.4 852.4 870.4 875.5 1043.1 22107.0 22239.7 22473.0 25948.0 26711.6 895.8 926.2 928.3 950.7 997.4 12637.4 13872.2 14503.6 14709.9 14731.3 196161.0 199140.0 199357.0 199651.0 199717.0 40613.0 40626.0 40805.2 40812.4 40957.0 1164.7 1177.9 1181.8 1196.7 1200.4 22047.9 25696.4 25926.4 26739.2 26912.7 35852.0 36097.1 36124.5 36140.5 36174.0 167493.0 168926.0 168948.0 169003.2 169324.2 23053.4 27691.2 30607.2 30991.5 31089.0 34583.8 35002.3 35675.5 35783.3 35808.0 30260.4 30382.4 30489.0 31434.6 31574.7 31144.8 31233.2 31466.0 31563.7 31619.1 30213.4 30919.0 31174.7 31175.4 31232.0 26581.7 28204.7 29304.3 29503.1 32451.0 21090.2 22004.6 22643.5 22787.9 22809.7 19:26:55 INFO - PROCESS | 7576 | 19:26:55 INFO - PROCESS | 7576 | [#2] jquery.html Cycles:180 Average:25836.61 Median:36868.95 stddev:81978.91 (222.4%) stddev-sans-first:82186.50 19:26:55 INFO - PROCESS | 7576 | Values: 324.9 330.0 331.3 331.9 336.7 11775.6 12206.1 14519.5 15019.3 15580.8 12359.1 15004.9 15978.2 16620.4 16621.8 4850.5 4987.1 5042.9 5212.8 5217.4 3427.1 3531.0 5152.9 5180.0 5180.8 5014.6 5135.5 5159.9 5173.8 5174.2 5120.6 5138.0 5150.5 5485.7 5872.2 5163.3 5167.6 5172.7 5174.9 5190.1 17378.6 17654.2 18085.2 18802.4 19330.0 1773.1 1786.6 1792.7 1811.7 1819.7 8897.3 8913.3 9176.0 9182.2 9191.2 1698.5 1728.3 1737.8 1757.7 1764.6 52832.7 53697.5 54902.0 57691.7 57913.4 9829.5 9908.2 9918.2 9944.7 10046.9 12635.9 12638.2 12641.1 12651.6 12658.8 6825.4 6865.4 6896.6 6933.1 6946.1 6583.5 6587.8 6603.7 6692.3 6715.3 4188.3 4244.5 4253.7 4282.6 4290.6 1587.3 1678.3 1724.8 1743.0 1750.4 754.0 795.0 854.7 861.1 967.9 15298.2 15435.7 15786.9 15809.4 15883.4 712.9 806.4 815.3 843.0 848.3 7848.9 7935.6 8240.2 8247.4 8332.0 484670.0 485910.0 486692.0 519379.0 538583.0 34936.0 35019.0 45893.8 66319.3 68414.3 1025.5 1027.0 1031.0 1076.2 1091.5 13033.6 13531.4 14221.5 14228.0 14311.9 29673.3 29936.9 30014.7 30375.4 31151.5 36516.5 37221.4 37248.8 38380.0 38569.2 8264.7 8385.8 8633.9 8684.1 8694.0 15173.7 15427.2 15435.5 15739.8 15752.1 13827.9 13853.2 13879.5 13908.8 14262.1 12622.7 12800.9 13212.7 13474.2 13700.1 10148.8 11668.4 14119.2 14299.4 14430.6 8493.8 8494.1 8497.8 8504.4 8513.9 13054.8 13058.2 13281.9 13355.5 13377.4 19:26:55 INFO - PROCESS | 7576 | 19:26:55 INFO - PROCESS | 7576 | [#3] mootools.html Cycles:180 Average:4862.69 Median:6132.36 stddev:2518.37 (41.1%) stddev-sans-first:2510.00 19:26:55 INFO - PROCESS | 7576 | Values: 1153.4 1357.4 1360.9 1467.2 1727.4 5748.0 5874.3 6915.2 7013.1 7028.6 6771.9 6813.0 6848.8 6859.3 6868.0 1616.1 1645.3 2016.1 2042.2 2045.0 2035.8 2075.2 2076.0 2079.2 2081.1 1954.4 1957.4 1963.9 2000.6 2003.5 1964.4 1978.6 1998.7 2000.6 2001.0 2005.9 2027.6 2029.2 2040.4 2041.2 6974.7 7051.6 7053.9 7054.1 7059.6 4115.1 4190.6 4203.1 4211.2 4226.6 2664.2 2700.4 2765.9 2785.9 2793.6 809.1 834.1 847.3 848.1 860.7 9450.2 9451.6 9457.3 9464.0 9465.1 3726.6 3780.1 3854.4 3879.0 3884.7 8167.0 8176.8 8189.5 8193.5 8194.6 4289.2 4292.1 4296.4 4298.0 4304.5 3875.0 3900.5 3904.6 3908.7 3910.0 2872.5 2909.8 3344.2 3375.9 3427.9 1044.9 1045.7 1062.7 1062.8 1065.9 859.8 914.7 926.4 927.8 939.8 6692.2 6771.7 6776.2 6788.8 6792.0 1004.2 1027.7 1031.0 1031.2 1050.4 5050.0 5147.4 5154.1 5158.7 5160.2 8056.3 8119.1 8203.5 8324.7 8339.8 8185.2 8217.1 8236.6 8266.7 8278.8 6556.3 6632.1 6683.9 6696.3 6697.7 6234.3 6288.5 6312.1 6324.8 6335.3 7340.6 7496.4 7539.7 7562.1 7587.9 7471.6 7555.5 7618.0 7676.5 7798.9 6117.0 6176.2 6179.0 6183.3 6183.4 5676.7 6461.9 6571.0 6661.9 6677.3 6214.2 6249.7 6333.8 6382.7 6473.0 5965.6 6112.2 6147.8 6275.2 6311.9 6202.6 6216.2 6266.2 6416.5 6418.9 5857.1 5860.4 5872.7 5877.1 5906.8 5988.5 5989.5 6045.9 6051.3 6058.9 19:26:55 INFO - PROCESS | 7576 | 19:26:55 INFO - PROCESS | 7576 | [#4] prototype.html Cycles:180 Average:4727.89 Median:5412.03 stddev:1417.44 (26.2%) stddev-sans-first:1381.68 19:26:55 INFO - PROCESS | 7576 | Values: 287.3 298.3 298.5 308.1 310.7 5340.9 5399.7 5437.8 5504.5 5553.4 5248.3 5400.5 5400.5 5401.6 5422.5 4187.4 4191.3 4191.7 4192.1 4201.1 3946.3 4052.1 4072.0 4149.1 4165.5 4109.9 4110.2 4115.9 4118.6 4130.5 4108.9 4110.4 4111.7 4111.8 4132.4 3584.4 3586.2 3589.2 3590.7 3591.3 5116.7 5245.6 5245.8 5258.9 5283.3 4755.4 4768.9 4774.1 4774.2 4780.1 5728.3 5741.1 5745.6 5755.7 5756.0 3712.3 3817.9 3820.5 3898.6 3908.8 5873.4 5913.3 5938.6 6016.1 6020.5 3994.7 4004.5 4007.4 4007.4 4015.7 4065.3 4065.6 4071.8 4077.6 4081.5 4591.2 4687.6 4711.0 4741.7 4753.9 5679.5 5680.7 5689.0 5692.4 5710.6 1420.7 1449.4 1450.6 1451.2 1451.5 953.8 962.9 964.3 966.0 966.1 4969.0 4976.2 4980.0 4983.8 4987.6 5937.9 5941.4 5942.8 5943.6 5949.9 4961.2 4971.0 4981.0 4990.2 4991.4 3129.8 3174.9 3180.9 3205.6 3215.9 5632.6 5633.6 5645.1 5648.7 5649.1 6082.1 6123.6 6123.6 6133.8 6144.1 5610.6 5619.7 5623.5 5627.7 5631.8 5804.3 5954.3 5999.2 6002.3 6004.4 5599.3 5661.9 5752.0 5806.9 5851.4 5645.5 5659.4 5663.3 5674.1 5674.6 4017.9 4073.0 4078.1 4078.8 4086.4 5830.5 5991.0 5991.2 5998.0 5999.7 5791.4 5792.4 5805.1 5811.9 5815.7 5803.3 5805.2 5806.3 5809.5 5811.5 5650.4 5654.5 5662.0 5664.5 5665.0 5625.8 5826.9 5832.2 5834.4 5835.0 5672.3 5678.8 5680.8 5681.0 5685.4 19:26:55 INFO - PROCESS | 7576 | 19:26:55 INFO - PROCESS | 7576 | [#5] yui.html Cycles:180 Average:11889.46 Median:523.27 stddev:13468.56 (2573.9%) stddev-sans-first:13479.83 19:26:55 INFO - PROCESS | 7576 | Values: 635.8 699.0 742.5 766.8 774.2 11078.3 11156.7 11194.7 11204.1 11246.7 10065.9 10825.6 11218.2 11306.1 11316.5 769.7 781.2 786.6 786.8 787.2 776.2 784.5 786.6 786.9 787.3 814.5 822.8 822.9 822.9 824.1 819.7 820.2 820.8 820.9 821.8 603.9 606.7 606.9 607.1 607.4 9666.9 9784.4 9801.9 9815.1 9824.7 9163.9 9326.3 9396.3 9555.0 9645.6 8238.3 8246.3 8264.0 8273.3 8285.5 2818.4 3102.6 3117.7 3124.4 3141.1 33829.8 37301.4 38424.4 43028.0 43036.4 9356.3 9441.6 9464.9 9473.2 9552.1 17063.6 17089.3 17100.7 17116.9 17138.4 6260.7 6439.8 6460.4 6557.9 6683.7 3517.1 3568.0 3572.1 3627.3 3639.8 2617.6 2651.8 2657.4 2659.6 2661.7 479.6 508.2 520.6 522.1 524.4 443.5 569.5 582.1 589.7 619.4 6893.2 7006.8 7027.8 7100.0 7155.4 567.7 571.8 594.3 600.5 605.7 3286.8 3461.4 3549.3 4041.3 4153.2 46095.5 46295.3 46352.3 46756.8 46898.1 42208.8 42874.4 42917.4 43512.6 44619.8 39962.8 40266.0 40658.6 40925.8 41115.4 7855.9 8147.0 8379.8 8420.9 8558.5 30098.7 30950.0 31235.0 31326.5 31424.4 37551.6 38283.6 41193.8 41279.2 41401.6 10148.8 10330.3 10344.9 10378.6 10526.0 11030.9 11046.4 11067.7 11085.2 11452.6 9679.4 9743.0 9766.2 9814.6 10191.2 10086.4 10295.6 10316.6 10363.6 10369.7 10691.5 10903.2 11062.9 11359.7 11362.3 9143.5 9165.7 9384.0 9402.5 9570.4 8453.4 8469.7 8515.1 8558.6 8592.5 19:26:55 INFO - PROCESS | 7576 | -------- Summary: end -------- 19:26:55 INFO - PROCESS | 7576 | 19:26:56 INFO - TEST-INFO | 7576: exit 0 19:26:56 INFO - TEST-OK | dromaeo_css | took 1116333ms 19:26:56 INFO - TEST-START | kraken 19:26:56 INFO - operating with platform_type : linux_ 19:26:56 INFO - Initialising browser for kraken test... 19:26:56 INFO - TEST-INFO | started process 7766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVmk_DD/profile http://localhost:33777/getInfo.html) 19:27:00 INFO - PROCESS | 7766 | __metrics Screen width/height:1600/1200 19:27:00 INFO - PROCESS | 7766 | colorDepth:24 19:27:00 INFO - PROCESS | 7766 | Browser inner width/height: 1024/697 19:27:00 INFO - PROCESS | 7766 | __metrics 19:27:00 INFO - PROCESS | 7766 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:27:00 INFO - PROCESS | 7766 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:27:01 INFO - TEST-INFO | 7766: exit 0 19:27:01 INFO - Browser initialized. 19:27:01 INFO - Running cycle 1/1 for kraken test... 19:27:01 INFO - TEST-INFO | started process 7851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVmk_DD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:13 INFO - PROCESS | 7851 | RSS: Main: 148537344 19:27:13 INFO - PROCESS | 7851 | 19:27:16 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33777/tests/kraken/driver.html?testName=audio-beat-detection) 19:27:16 INFO - PROCESS | 7851 | RSS: Main: 185212928 19:27:16 INFO - PROCESS | 7851 | 19:27:19 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33777/tests/kraken/driver.html?testName=audio-dft) 19:27:20 INFO - PROCESS | 7851 | RSS: Main: 174223360 19:27:20 INFO - PROCESS | 7851 | 19:27:23 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33777/tests/kraken/driver.html?testName=audio-fft) 19:27:23 INFO - PROCESS | 7851 | RSS: Main: 160055296 19:27:23 INFO - PROCESS | 7851 | 19:27:25 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33777/tests/kraken/driver.html?testName=audio-oscillator) 19:27:26 INFO - PROCESS | 7851 | RSS: Main: 162959360 19:27:26 INFO - PROCESS | 7851 | 19:27:28 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33777/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:27:29 INFO - PROCESS | 7851 | RSS: Main: 165117952 19:27:29 INFO - PROCESS | 7851 | 19:27:32 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33777/tests/kraken/driver.html?testName=imaging-darkroom) 19:27:32 INFO - PROCESS | 7851 | RSS: Main: 164536320 19:27:32 INFO - PROCESS | 7851 | 19:27:36 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33777/tests/kraken/driver.html?testName=imaging-desaturate) 19:27:36 INFO - PROCESS | 7851 | RSS: Main: 167116800 19:27:36 INFO - PROCESS | 7851 | 19:27:39 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33777/tests/kraken/driver.html?testName=json-parse-financial) 19:27:40 INFO - PROCESS | 7851 | RSS: Main: 166793216 19:27:40 INFO - PROCESS | 7851 | 19:27:41 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33777/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:27:42 INFO - PROCESS | 7851 | RSS: Main: 175132672 19:27:42 INFO - PROCESS | 7851 | 19:27:44 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33777/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:27:44 INFO - PROCESS | 7851 | RSS: Main: 174125056 19:27:44 INFO - PROCESS | 7851 | 19:27:46 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33777/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:27:47 INFO - PROCESS | 7851 | RSS: Main: 186404864 19:27:47 INFO - PROCESS | 7851 | 19:27:49 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:27:50 INFO - PROCESS | 7851 | RSS: Main: 190222336 19:27:50 INFO - PROCESS | 7851 | 19:27:53 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:27:53 INFO - PROCESS | 7851 | RSS: Main: 188149760 19:27:53 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | Cycle 1(1): loaded http://localhost:33777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33777/tests/kraken/driver.html?testName=ai-astar) 19:27:55 INFO - PROCESS | 7851 | RSS: Main: 245403648 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | __start_tp_report 19:27:55 INFO - PROCESS | 7851 | _x_x_mozilla_page_load 19:27:55 INFO - PROCESS | 7851 | _x_x_mozilla_page_load_details 19:27:55 INFO - PROCESS | 7851 | |i|pagename|runs| 19:27:55 INFO - PROCESS | 7851 | |0;ai-astar;111;113;109;113;113;113;103;112;112;106 19:27:55 INFO - PROCESS | 7851 | |1;audio-beat-detection;152;137;147;168;132;164;158;131;172;143 19:27:55 INFO - PROCESS | 7851 | |2;audio-dft;162;160;160;161;163;160;159;161;161;163 19:27:55 INFO - PROCESS | 7851 | |3;audio-fft;72;72;81;92;73;72;73;99;91;72 19:27:55 INFO - PROCESS | 7851 | |4;audio-oscillator;96;97;146;96;97;97;139;96;96;135 19:27:55 INFO - PROCESS | 7851 | |5;imaging-gaussian-blur;109;110;109;109;109;109;109;110;109;109 19:27:55 INFO - PROCESS | 7851 | |6;imaging-darkroom;148;147;146;146;146;147;146;146;146;147 19:27:55 INFO - PROCESS | 7851 | |7;imaging-desaturate;96;97;95;96;96;95;96;96;96;96 19:27:55 INFO - PROCESS | 7851 | |8;json-parse-financial;68;69;68;69;69;69;72;81;66;69 19:27:55 INFO - PROCESS | 7851 | |9;json-stringify-tinderbox;69;70;70;69;69;68;69;69;69;69 19:27:55 INFO - PROCESS | 7851 | |10;stanford-crypto-aes;92;84;83;84;84;83;84;84;85;85 19:27:55 INFO - PROCESS | 7851 | |11;stanford-crypto-ccm;122;125;121;121;124;121;129;122;128;119 19:27:55 INFO - PROCESS | 7851 | |12;stanford-crypto-pbkdf2;141;148;161;151;141;142;149;148;148;136 19:27:55 INFO - PROCESS | 7851 | |13;stanford-crypto-sha256-iterative;71;69;70;69;70;69;70;69;68;68 19:27:55 INFO - PROCESS | 7851 | __end_tp_report 19:27:55 INFO - PROCESS | 7851 | __start_cc_report 19:27:55 INFO - PROCESS | 7851 | _x_x_mozilla_cycle_collect,978 19:27:55 INFO - PROCESS | 7851 | __end_cc_report 19:27:55 INFO - PROCESS | 7851 | __startTimestamp1451100475748__endTimestamp 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | ------- Summary: start ------- 19:27:55 INFO - PROCESS | 7851 | Number of tests: 14 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.50 stddev:3.47 (3.1%) stddev-sans-first:3.68 19:27:55 INFO - PROCESS | 7851 | Values: 111.0 113.0 109.0 113.0 113.0 113.0 103.0 112.0 112.0 106.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:155.00 stddev:14.84 (9.6%) stddev-sans-first:15.73 19:27:55 INFO - PROCESS | 7851 | Values: 152.0 137.0 147.0 168.0 132.0 164.0 158.0 131.0 172.0 143.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.33 (0.8%) stddev-sans-first:1.36 19:27:55 INFO - PROCESS | 7851 | Values: 162.0 160.0 160.0 161.0 163.0 160.0 159.0 161.0 161.0 163.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#3] audio-fft Cycles:10 Average:79.70 Median:77.00 stddev:10.44 (13.6%) stddev-sans-first:10.69 19:27:55 INFO - PROCESS | 7851 | Values: 72.0 72.0 81.0 92.0 73.0 72.0 73.0 99.0 91.0 72.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:21.21 (22.1%) stddev-sans-first:21.93 19:27:55 INFO - PROCESS | 7851 | Values: 96.0 97.0 146.0 96.0 97.0 97.0 139.0 96.0 96.0 135.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:27:55 INFO - PROCESS | 7851 | Values: 109.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 19:27:55 INFO - PROCESS | 7851 | Values: 148.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 19:27:55 INFO - PROCESS | 7851 | Values: 96.0 97.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#8] json-parse-financial Cycles:10 Average:70.00 Median:69.00 stddev:4.14 (6.0%) stddev-sans-first:4.32 19:27:55 INFO - PROCESS | 7851 | Values: 68.0 69.0 68.0 69.0 69.0 69.0 72.0 81.0 66.0 69.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 19:27:55 INFO - PROCESS | 7851 | Values: 69.0 70.0 70.0 69.0 69.0 68.0 69.0 69.0 69.0 69.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.00 stddev:2.62 (3.1%) stddev-sans-first:0.71 19:27:55 INFO - PROCESS | 7851 | Values: 92.0 84.0 83.0 84.0 84.0 83.0 84.0 84.0 85.0 85.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:123.00 stddev:3.26 (2.6%) stddev-sans-first:3.43 19:27:55 INFO - PROCESS | 7851 | Values: 122.0 125.0 121.0 121.0 124.0 121.0 129.0 122.0 128.0 119.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:148.00 stddev:6.95 (4.7%) stddev-sans-first:7.08 19:27:55 INFO - PROCESS | 7851 | Values: 141.0 148.0 161.0 151.0 141.0 142.0 149.0 148.0 148.0 136.0 19:27:55 INFO - PROCESS | 7851 | 19:27:55 INFO - PROCESS | 7851 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:0.95 (1.4%) stddev-sans-first:0.78 19:27:55 INFO - PROCESS | 7851 | Values: 71.0 69.0 70.0 69.0 70.0 69.0 70.0 69.0 68.0 68.0 19:27:55 INFO - PROCESS | 7851 | -------- Summary: end -------- 19:27:55 INFO - PROCESS | 7851 | 19:27:56 INFO - TEST-INFO | 7851: exit 0 19:27:56 INFO - TEST-OK | kraken | took 60214ms 19:27:56 INFO - TEST-START | v8_7 19:27:56 INFO - operating with platform_type : linux_ 19:27:56 INFO - Initialising browser for v8_7 test... 19:27:56 INFO - TEST-INFO | started process 8097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1KyAaI/profile http://localhost:33777/getInfo.html) 19:28:00 INFO - PROCESS | 8097 | __metrics Screen width/height:1600/1200 19:28:00 INFO - PROCESS | 8097 | colorDepth:24 19:28:00 INFO - PROCESS | 8097 | Browser inner width/height: 1024/697 19:28:00 INFO - PROCESS | 8097 | __metrics 19:28:00 INFO - PROCESS | 8097 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:28:01 INFO - PROCESS | 8097 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:28:01 INFO - TEST-INFO | 8097: exit 0 19:28:01 INFO - Browser initialized. 19:28:01 INFO - Running cycle 1/1 for v8_7 test... 19:28:01 INFO - TEST-INFO | started process 8179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1KyAaI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:13 INFO - PROCESS | 8179 | RSS: Main: 148885504 19:28:13 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | Cycle 1(1): loaded http://localhost:33777/tests/v8_7/run.html (next: http://localhost:33777/tests/v8_7/run.html) 19:28:35 INFO - PROCESS | 8179 | RSS: Main: 449847296 19:28:35 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | __start_tp_report 19:28:35 INFO - PROCESS | 8179 | _x_x_mozilla_page_load 19:28:35 INFO - PROCESS | 8179 | _x_x_mozilla_page_load_details 19:28:35 INFO - PROCESS | 8179 | |i|pagename|runs| 19:28:35 INFO - PROCESS | 8179 | |0;Richards;168.63406408094434 19:28:35 INFO - PROCESS | 8179 | |1;DeltaBlue;187.82870022539444 19:28:35 INFO - PROCESS | 8179 | |2;Encrypt;279.17364600781684 19:28:35 INFO - PROCESS | 8179 | |3;Decrypt;5256.544502617801 19:28:35 INFO - PROCESS | 8179 | |4;RayTrace;1988.0715705765408 19:28:35 INFO - PROCESS | 8179 | |5;Earley;804.0160642570281 19:28:35 INFO - PROCESS | 8179 | |6;Boyer;12180.722891566265 19:28:35 INFO - PROCESS | 8179 | |7;RegExp;27270.27027027027 19:28:35 INFO - PROCESS | 8179 | |8;Splay;622.5124378109452 19:28:35 INFO - PROCESS | 8179 | |9;NavierStokes;4897.5609756097565 19:28:35 INFO - PROCESS | 8179 | __end_tp_report 19:28:35 INFO - PROCESS | 8179 | __startTimestamp1451100515506__endTimestamp 19:28:35 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | ------- Summary: start ------- 19:28:35 INFO - PROCESS | 8179 | Number of tests: 10 19:28:35 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | [#0] Richards Cycles:1 Average:168.63 Median:168.63 stddev:0.00 (0.0%) 19:28:35 INFO - PROCESS | 8179 | Values: 168.6 19:28:35 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | [#1] DeltaBlue Cycles:1 Average:187.83 Median:187.83 stddev:0.00 (0.0%) 19:28:35 INFO - PROCESS | 8179 | Values: 187.8 19:28:35 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 19:28:35 INFO - PROCESS | 8179 | Values: 279.2 19:28:35 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 19:28:35 INFO - PROCESS | 8179 | Values: 5256.5 19:28:35 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 19:28:35 INFO - PROCESS | 8179 | Values: 1988.1 19:28:35 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | [#5] Earley Cycles:1 Average:804.02 Median:804.02 stddev:0.00 (0.0%) 19:28:35 INFO - PROCESS | 8179 | Values: 804.0 19:28:35 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 19:28:35 INFO - PROCESS | 8179 | Values: 12180.7 19:28:35 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | [#7] RegExp Cycles:1 Average:27270.27 Median:27270.27 stddev:0.00 (0.0%) 19:28:35 INFO - PROCESS | 8179 | Values: 27270.3 19:28:35 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | [#8] Splay Cycles:1 Average:622.51 Median:622.51 stddev:0.00 (0.0%) 19:28:35 INFO - PROCESS | 8179 | Values: 622.5 19:28:35 INFO - PROCESS | 8179 | 19:28:35 INFO - PROCESS | 8179 | [#9] NavierStokes Cycles:1 Average:4897.56 Median:4897.56 stddev:0.00 (0.0%) 19:28:35 INFO - PROCESS | 8179 | Values: 4897.6 19:28:35 INFO - PROCESS | 8179 | -------- Summary: end -------- 19:28:35 INFO - PROCESS | 8179 | 19:28:36 INFO - TEST-INFO | 8179: exit 0 19:28:36 INFO - TEST-OK | v8_7 | took 39778ms 19:28:36 INFO - SUITE-END | took 1216s 19:28:36 INFO - Completed test suite (00:20:16) 19:28:36 INFO - Working with test: dromaeo_css 19:28:36 INFO - Generating results file: dromaeo_css 19:28:36 INFO - Working with test: kraken 19:28:36 INFO - Generating results file: kraken 19:28:36 INFO - javascript benchmark 19:28:36 INFO - Working with test: v8_7 19:28:36 INFO - Generating results file: v8_7 19:28:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:28:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 19:28:36 INFO - process_Request line: dromaeo_css 6161.79 graph.html#tests=[[72,203,35]] 19:28:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:28:36 INFO - process_Request line: kraken 1525.60 graph.html#tests=[[232,203,35]] 19:28:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:28:36 INFO - process_Request line: v8_7 19579.71 graph.html#tests=[[230,203,35]] 19:28:36 INFO - RETURN: dromaeo_css: 6161.79 19:28:36 INFO - RETURN: kraken: 1525.60 19:28:36 INFO - RETURN: v8_7: 19579.71 19:28:36 INFO - javascript benchmark 19:28:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2569.659288486352, 2670.279024663342, 2677.0228866463744, 2683.651125353705, 2691.609716591094, 4423.513413524518, 4529.479109902362, 4555.0, 4620.052889157723, 4623.445186577607, 4540.432445944257, 4581.656375771814, 4631.745254011028, 4645.744484053375, 4650.116477869203, 4187.1625674865, 4211.199872024321, 4264.658827293817, 4330.891727706801, 4378.934315985262, 4061.248668996245, 4333.176696427684, 4349.521552629209, 4382.364557139229, 4383.736975781448, 4157.833686652531, 4251.723637963553, 4323.956760432387, 4334.436523251957, 4381.518033016366, 4290.806913688892, 4297.72064815786, 4310.870673879788, 4349.630281426083, 4353.08585197109, 4114.465119534471, 4266.743995360288, 4289.914201715948, 4317.179735850178, 4357.869263922087, 4457.353683715875, 4457.9331310030375, 4525.479569849444, 4590.0, 4635.6986795858165, 4922.876928076791, 4931.408231012301, 4932.8520144395725, 4945.530174633404, 4971.055499455092, 4727.409073865767, 4914.287428322909, 4932.899875116447, 4935.457099719028, 4954.380702412199, 4513.119941611354, 4528.026474308007, 4570.474395444567, 4638.327442520883, 4659.091477161988, 5023.34696489454, 5025.346704928409, 5027.4469808321055, 5027.547520723152, 5060.49395060491, 4820.927686084711, 4823.083614113307, 4823.397075365579, 4829.0, 4859.0, 4661.021185551004, 4753.714777113315, 4765.475797662254, 4766.713997160112, 4910.116179087799, 4892.119418504632, 4951.554360107608, 4956.330895329156, 4957.058158949788, 4991.975040124777, 4887.804487820447, 4910.558049775537, 4919.508049195052, 4928.112939670822, 4964.15609346412, 3935.704822138351, 4042.91914161721, 4114.485689288839, 4159.209750147463, 4178.22702799983, 3580.0870777951977, 3596.1009747563107, 3632.3824949758605, 3659.7804131751645, 3662.3957047087465, 4224.894377640522, 4227.3447615619625, 4237.322028475429, 4241.554636763157, 4273.893152671146, 4709.552592503706, 4810.302506136591, 4926.433460152057, 4940.505949405103, 4986.925196122061, 4146.606072423115, 4152.169566086734, 4202.474690663667, 4209.24233637942, 4241.575842415796, 4357.346398040319, 4370.628496577827, 4371.082072764755, 4405.074934263776, 4409.14021765759, 4519.254323036662, 4621.445426548701, 4668.11305851887, 4685.695429797121, 4718.764061796828, 4819.108464933858, 4906.730129842893, 4967.478414766398, 4995.275685025578, 5026.974865125651, 4735.83424580138, 4738.763061846963, 4749.691270067435, 4791.976040119777, 4795.232762757942, 4715.575598196178, 4815.446223684321, 4922.286268490977, 4947.678400903929, 4982.825601103944, 4833.419989601271, 4871.975640121776, 4906.705597664151, 4925.261210818406, 4975.0796102721115, 4742.928856067231, 4766.285057241442, 4771.761411929459, 4776.904461910812, 4818.036392721539, 4645.442546894395, 4752.239641657318, 4777.259524773665, 4777.713337199779, 4820.204666230173, 4551.726896386227, 4638.188317044571, 4672.08894265615, 4705.76471176433, 4715.575598196178, 4797.592204662643, 4805.423349198119, 4805.495422980537, 4806.6875653083835, 4864.027194561031, 4518.254488009573, 4703.412073490814, 4704.92942605868, 4710.505396933273, 4710.9764451177525], "unit": "score", "name": "dojo.html", "value": 4515.329144101629}, {"lowerIsBetter": false, "replicates": [534.3774502704347, 547.3158551810237, 548.8448457839803, 575.0425541473446, 588.9882202355953, 23710.644340334886, 24186.395340116484, 33006.33987320255, 33453.0, 33497.33005339892, 35932.0, 36372.636273637254, 36472.81763591185, 36480.81759591205, 36492.270154596896, 6702.631355275458, 6757.425618822382, 7565.62171891406, 7719.189485104067, 7728.652210650506, 9800.068993445648, 10013.749656258578, 10015.699529014104, 10018.298719089667, 10024.19806415485, 9626.518674066268, 9715.854262186072, 9731.464769437678, 9743.658971935984, 9761.170300524429, 6899.655017249117, 7062.223155452896, 9665.46839923804, 9836.262280329003, 10031.89968100317, 9442.150206481381, 9530.90469095314, 9537.666181683608, 9540.189083927875, 9541.904580954171, 32185.83907080473, 32557.51163732546, 32558.18604534882, 32571.674283257336, 32576.67423325784, 2773.4715749071684, 2882.2938380096803, 2899.1882272963603, 2900.8114472559214, 3371.6291207967106, 27541.586876196874, 27918.581221281696, 27957.86021069902, 28033.0, 28055.29861753452, 3369.126980958841, 3435.5362026126404, 3438.8796392126155, 3516.5604299462566, 3549.6450354964554, 162394.0, 163739.0, 163795.0, 163979.0, 164468.17765911095, 43403.0, 54264.186037209474, 54359.18461223085, 54373.72813135909, 54613.45386546083, 37461.62538374636, 57104.42895570991, 58009.709951450815, 58572.414275856696, 58625.41374586285, 11864.0, 12023.338716370508, 12077.879221207852, 12084.395780210954, 12127.939360303142, 9736.318457708034, 9772.16936560386, 9802.509874506246, 9846.261530385107, 9852.359596626196, 17645.0, 17753.822461775217, 17754.37859674905, 17824.732629010574, 18558.164882580317, 6875.209350924708, 7519.323260906544, 7549.245075492407, 7572.318491335806, 7575.280348366897, 786.3669745854642, 852.3692467573951, 870.4037734152126, 875.5490922175085, 1043.087298613713, 22107.0, 22239.742911605787, 22473.0, 25948.0, 26711.599326010124, 895.8387490251687, 926.249737712455, 928.2805825485168, 950.695777351241, 997.3915911294105, 12637.368131593568, 13872.237026963412, 14503.564893053226, 14709.852901471062, 14731.337089830984, 196161.0, 199140.0, 199357.0, 199651.0, 199717.0, 40613.0, 40626.0, 40805.1838963225, 40812.38781418281, 40957.0, 1164.7262893220086, 1177.8704342522315, 1181.7931861924128, 1196.6529706385052, 1200.3878022208562, 22047.889760551094, 25696.357591060372, 25926.35184120412, 26739.197824065308, 26912.730872691805, 35852.0, 36097.097572560895, 36124.45813312855, 36140.4578931311, 36174.0, 167493.0, 168926.0, 168948.0, 169003.1549842243, 169324.15337923725, 23053.423664408525, 27691.169264922086, 30607.234819128807, 30991.535126973566, 31089.0, 34583.82708086444, 35002.29995400027, 35675.46486802648, 35783.284334312644, 35808.0, 30260.394792103594, 30382.392352153274, 30489.0, 31434.59915611862, 31574.684253158095, 31144.844275778476, 31233.219169520944, 31466.0, 31563.684363156994, 31619.051428457184, 30213.395732084795, 30919.0, 31174.68825311718, 31175.376492470477, 31232.0, 26581.734182657925, 28204.71795282103, 29304.26739331534, 29503.114906552837, 32451.0, 21090.156393744077, 22004.559908802054, 22643.547129057657, 22787.88606056959, 22809.657855131853], "unit": "score", "name": "ext.html", "value": 15942.268611205753}, {"lowerIsBetter": false, "replicates": [324.93338865532576, 329.965353637868, 331.2712033526243, 331.8683289981164, 336.71547542326726, 11775.587854425097, 12206.084543659217, 14519.49181778638, 15019.32413041413, 15580.84419155808, 12359.073069519776, 15004.924975375108, 15978.201089945514, 16620.418285360014, 16621.750673739873, 4850.46644869065, 4987.077390682717, 5042.899142017158, 5212.76542555584, 5217.426083130871, 3427.091820667525, 3531.0113168312914, 5152.896942061157, 5179.974100129494, 5180.766865491062, 5014.623903207255, 5135.460776618457, 5159.871003224931, 5173.793048278064, 5174.197999310113, 5120.615953803443, 5137.998090372379, 5150.459201783815, 5485.725713714299, 5872.236609240814, 5163.277141200235, 5167.638265321429, 5172.689638621657, 5174.870628234286, 5190.143626301656, 17378.565535861577, 17654.205560749797, 18085.186166622534, 18802.435926922215, 19330.0, 1773.1045821860007, 1786.553361659585, 1792.6952418088956, 1811.7191835265423, 1819.6815557277423, 8897.288216942694, 8913.28693704502, 9176.03651616584, 9182.173604375572, 9191.172794448465, 1698.524413164316, 1728.3086765293858, 1737.7654016707709, 1757.7187649975942, 1764.5765016396101, 52832.73583632057, 53697.46302536964, 54902.0, 57691.71154144244, 57913.420865791224, 9829.508524573743, 9908.20734341251, 9918.15695665862, 9944.701658950244, 10046.899531004596, 12635.87364126347, 12638.178518396275, 12641.11512194156, 12651.620451386472, 12658.81011784824, 6825.419839313615, 6865.382115609519, 6896.620685862325, 6933.1333583302085, 6946.097007389007, 6583.539152259296, 6587.769428069994, 6603.669816509156, 6692.297308782605, 6715.328467153246, 4188.32986722123, 4244.511881133709, 4253.659707223414, 4282.571742825755, 4290.570942905684, 1587.2539906244047, 1678.2531773360981, 1724.8016478104928, 1742.9651406972043, 1750.422360620992, 753.9698412063566, 794.9602519873984, 854.6666799948025, 861.1431625532636, 967.9177269931994, 15298.235088245543, 15435.691286174439, 15786.921065394828, 15809.367625294859, 15883.364665413254, 712.9465290103263, 806.4234072638092, 815.3069890593067, 843.0389356134012, 848.3001523742813, 7848.882266766003, 7935.563544005136, 8240.21717936795, 8247.422680412434, 8331.95850518685, 484670.0, 485910.0, 486692.0, 519379.0, 538583.0, 34936.0, 35019.0, 45893.77053114713, 66319.33680663229, 68414.3158568408, 1025.5077562769764, 1026.97432564185, 1030.9587616495405, 1076.1659713721929, 1091.5306418240234, 13033.608991730263, 13531.391087400894, 14221.502247421291, 14228.0, 14311.856881431053, 29673.258168545097, 29936.850315749154, 30014.69985300119, 30375.392492149593, 31151.53272700866, 36516.45225321569, 37221.44167837431, 37248.81375593105, 38380.0, 38569.228615428096, 8264.710735124241, 8385.83228335442, 8633.91366086331, 8684.088170742234, 8693.956530217309, 15173.696526069638, 15427.228638568251, 15435.459758908384, 15739.763903541227, 15752.133632650315, 13827.861721382658, 13853.16880987144, 13879.514217002357, 13908.791368129689, 14262.144271343752, 12622.747545049231, 12800.86378837191, 13212.669683257995, 13474.19154850712, 13700.109492882932, 10148.847767283349, 11668.358240296866, 14119.152850828983, 14299.35652895643, 14430.567082987527, 8493.787655308666, 8494.088830013197, 8497.787555311166, 8504.362172837185, 8513.914860851311, 13054.804177937149, 13058.21650700961, 13281.933590331986, 13355.465781368637, 13377.398017089059], "unit": "score", "name": "jquery.html", "value": 8013.710042415032}, {"lowerIsBetter": false, "replicates": [1153.3771763247846, 1357.3688234970737, 1360.897932655051, 1467.2370367408948, 1727.3608764757034, 5747.971260143699, 5874.3244526879425, 6915.204751453584, 7013.088298521197, 7028.648567571614, 6771.8984215236815, 6813.046173535709, 6848.794536163923, 6859.279775623562, 6868.0, 1616.0707593133936, 1645.3336398758463, 2016.0524553459886, 2042.1627132875524, 2045.0, 2035.8269547088514, 2075.169932027186, 2076.0346438905904, 2079.189116244666, 2081.1259271106096, 1954.4039068084228, 1957.4340527577951, 1963.8919859407727, 2000.5898790747863, 2003.459066052165, 1964.3812199157219, 1978.6042791441698, 1998.670219413795, 2000.5898790747863, 2001.0495014867968, 2005.8896760678158, 2027.6147531969027, 2029.249177804222, 2040.3878836349036, 2041.1529215375601, 6974.721011159548, 7051.612161331124, 7053.89419158713, 7054.118235220598, 7059.611721355323, 4115.053537686349, 4190.580941905816, 4203.117345357478, 4211.157768446323, 4226.619604235603, 2664.1607893513483, 2700.419409826877, 2765.8893644254204, 2785.874635641381, 2793.5530315149476, 809.1140201479429, 834.1491678487969, 847.3179090831878, 848.0586548930683, 860.7460799064291, 9450.243980481613, 9451.574679139387, 9457.33798634096, 9463.952680236554, 9465.053494650549, 3726.571444283942, 3780.1305699689224, 3854.402567602026, 3879.049632839972, 3884.7280690351968, 8167.0199576051255, 8176.836463270702, 8189.50862948225, 8193.50838949653, 8194.590270486571, 4289.1850548395705, 4292.077203401283, 4296.355546667963, 4298.032942587893, 4304.48346198452, 3874.9612503875164, 3900.473436086149, 3904.6095390460728, 3908.6677632401565, 3910.022494376406, 2872.5116730155924, 2909.796314258024, 3344.2475443025123, 3375.8649654014057, 3427.9485807712904, 1044.9059584637419, 1045.6601604478574, 1062.7024433158729, 1062.8193207154802, 1065.872095348563, 859.7936495241097, 914.721010091915, 926.4487629860222, 927.8005228875824, 939.7603611079131, 6692.163479565054, 6771.695273712695, 6776.15298087739, 6788.8302792429595, 6792.0, 1004.2217281606813, 1027.671145233518, 1030.953607087683, 1031.1905154453868, 1050.3907733514543, 5050.0, 5147.382314122255, 5154.072266991902, 5158.664686795346, 5160.174372100446, 8056.274935255855, 8119.106898241189, 8203.548804815793, 8324.70863519786, 8339.791505212297, 8185.181481851767, 8217.055038670629, 8236.629351679188, 8266.669333226604, 8278.793030174294, 6556.3443655634055, 6632.1046658701425, 6683.933160668428, 6696.330366963265, 6697.732090716317, 6234.314225435108, 6288.465480434214, 6312.084747711464, 6324.841878953063, 6335.334789847184, 7340.596267205141, 7496.362809161283, 7539.698412063456, 7562.130355009024, 7587.886181707389, 7471.626418678936, 7555.546667199986, 7618.0, 7676.462647614613, 7798.883016754639, 6116.969415152896, 6176.197094377702, 6178.969105154445, 6183.319834818257, 6183.350748171377, 5676.7161641918565, 6461.903071453838, 6571.0, 6661.866762664623, 6677.2988836173445, 6214.223222097238, 6249.7187626557825, 6333.841653958688, 6382.68086595659, 6473.029045643191, 5965.612235204698, 6112.235970503687, 6147.754089836357, 6275.215598050244, 6311.873762524632, 6202.627842329474, 6216.222972128484, 6266.248050234001, 6416.51876109303, 6418.903716444351, 5857.092150716646, 5860.38465961068, 5872.706364681834, 5877.089051197071, 5906.793262235801, 5988.520918326611, 5989.52083833301, 6045.879082418415, 6051.334353221054, 6058.878822423439], "unit": "score", "name": "mootools.html", "value": 3982.3868886144637}, {"lowerIsBetter": false, "replicates": [287.31332116242186, 298.2885817325678, 298.4746845551828, 308.092667095404, 310.6924145096352, 5340.866478338044, 5399.730013499329, 5437.755301011454, 5504.504594586487, 5553.361363443195, 5248.265242865992, 5400.459954004597, 5400.540954018913, 5401.567874570025, 5422.48486393792, 4187.413762073312, 4191.287481128208, 4191.664666826647, 4192.140611174702, 4201.075763332062, 3946.3093958557283, 4052.128792309653, 4072.0430698785763, 4149.128682976579, 4165.500139983206, 4109.938350924738, 4110.157417729373, 4115.8971025724295, 4118.588141185887, 4130.463039804821, 4108.856190033334, 4110.403991421257, 4111.732737372061, 4111.835526578948, 4132.380142978547, 3584.426491761332, 3586.2110335726097, 3589.246258285763, 3590.6768390844686, 3591.299696559172, 5116.69299842007, 5245.606579506514, 5245.816396426107, 5258.894822103574, 5283.339582552181, 4755.405574303212, 4768.904621907543, 4774.092922344744, 4774.188387974018, 4780.091782561302, 5728.283964504437, 5741.110127930177, 5745.626534275259, 5755.740991655385, 5755.971220143872, 3712.3317802795486, 3817.866374676873, 3820.541535015788, 3898.571157172709, 3908.7850168240734, 5873.442023007808, 5913.2608423947, 5938.6436813791315, 6016.097585362187, 6020.488258497989, 3994.720369574102, 4004.4593979812935, 4007.358822588372, 4007.358822588372, 4015.658669013108, 4065.3495440729343, 4065.5527891931865, 4071.776052317151, 4077.55146933837, 4081.5102187737066, 4591.1965406053805, 4687.6249900007915, 4711.0, 4741.739204343725, 4753.904921901542, 5679.545636349082, 5680.687562184037, 5688.971555142198, 5692.402297758758, 5710.628809127394, 1420.6732451536204, 1449.3622805965342, 1450.557579938129, 1451.165579791624, 1451.5282533176548, 953.7949340891741, 962.932594718377, 964.2575217082807, 965.9517024148764, 966.0725703324887, 4968.950310496921, 4976.2286845539, 4979.975100124549, 4983.825566105169, 4987.600991920638, 5937.910931336033, 5941.435563621449, 5942.7920022799, 5943.64338139713, 5949.881002379928, 4961.231009193581, 4970.975145124251, 4980.950190498121, 4990.176620857518, 4991.401031876198, 3129.8278594677513, 3174.873005079771, 3180.904572862818, 3205.6313523944577, 3215.903522894317, 5632.633878797865, 5633.605647604711, 5645.068563687028, 5648.6893220872425, 5649.12438572022, 6082.087686847009, 6123.601965872204, 6123.632582045091, 6133.815985520441, 6144.078388241799, 5610.635308704921, 5619.690916999522, 5623.493885550321, 5627.690477023639, 5631.802886898939, 5804.332501762351, 5954.3152537458745, 5999.190109335358, 6002.279726432856, 6004.369541198286, 5599.272094627672, 5661.858453538694, 5752.0, 5806.912896306643, 5851.444112809277, 5645.491905728504, 5659.405762395054, 5663.263775709132, 5674.063779476505, 5674.631148975303, 4017.879463615979, 4073.0224746061326, 4078.0620457294394, 4078.775667338325, 4086.40747091676, 5830.47525722687, 5991.0, 5991.161237426677, 5998.0, 5999.670018149044, 5791.420857914175, 5792.4497172768515, 5805.129230615442, 5811.854703632443, 5815.680137592304, 5803.303603567599, 5805.216295800182, 5806.274215723035, 5809.477147056617, 5811.506021988178, 5650.434956504317, 5654.547636189012, 5662.037453632975, 5664.49019588239, 5665.0, 5625.803096891589, 5826.883462330645, 5832.212651292191, 5834.358220595646, 5835.0, 5672.262605861211, 5678.829635110953, 5680.801171958961, 5681.0, 5685.431456854281], "unit": "score", "name": "prototype.html", "value": 4267.807972697748}, {"lowerIsBetter": false, "replicates": [635.7806556737927, 698.9585517578809, 742.4913933955245, 766.8197973476232, 774.2219069834815, 11078.279911805726, 11156.721081972955, 11194.664160075201, 11204.103671706263, 11246.662600121988, 10065.899341006587, 10825.621103261388, 11218.158638102133, 11306.095512359012, 11316.547338106466, 769.7075111457652, 781.2109769133159, 786.5634572812087, 786.7639708087579, 787.1538096546207, 776.1617453150612, 784.5449639209273, 786.6145588661572, 786.8622990976556, 787.3465024030041, 814.539785021461, 822.8189798244376, 822.8642274024779, 822.9053658829251, 824.056455358614, 819.7499762572413, 820.151143566406, 820.8112134209106, 820.9014918209823, 821.7822277096574, 603.8882806680734, 606.6754286456725, 606.8816580766752, 607.1287702147432, 607.3531688751509, 9666.903330966741, 9784.364016338986, 9801.852972205423, 9815.067568581046, 9824.656137035241, 9163.908360916439, 9326.347155699104, 9396.29527785412, 9554.9522252389, 9645.614175432975, 8238.299744521662, 8246.340292776624, 8263.95868020656, 8273.296769774577, 8285.54429506383, 2818.3658676797763, 3102.58036386699, 3117.688231176887, 3124.375124975014, 3141.0576826951824, 33829.830850845836, 37301.44047839285, 38424.423633645514, 43028.0, 43036.354454683205, 9356.34505584616, 9441.622335106518, 9464.858027129598, 9473.194778443773, 9552.092551207625, 17063.573410664834, 17089.316427343016, 17100.74348884768, 17116.91441542809, 17138.40015599448, 6260.68696565179, 6439.80680579574, 6460.418562329319, 6557.868842623121, 6683.665816709243, 3517.1031386996665, 3567.982160089183, 3572.142685755452, 3627.2564124354444, 3639.7998110103667, 2617.633531305619, 2651.7613414792763, 2657.4419371932113, 2659.614355918381, 2661.6672915885515, 479.5971384037425, 508.1767536590747, 520.570529313318, 522.1071966936581, 524.4336116993637, 443.54758146690193, 569.5159114752428, 582.1384351160222, 589.711041589618, 619.4239357397663, 6893.216950893061, 7006.75476358325, 7027.8243043923285, 7100.0, 7155.356017958408, 567.7076305702567, 571.7712914834017, 594.3195041677255, 600.4835841176584, 605.7032054293364, 3286.819224942651, 3461.376952148587, 3549.290141971616, 4041.2927737645796, 4153.190127925086, 46095.539044609795, 46295.30557041647, 46352.304715429294, 46756.766216168704, 46898.062038759716, 42208.788956055025, 42874.35688464675, 42917.35623965643, 43512.56487435085, 44619.77690111593, 39962.80018599889, 40266.0, 40658.59341406548, 40925.795371022956, 41115.383269250386, 7855.921440785519, 8146.959265203636, 8379.83240335202, 8420.87368689458, 8558.486490810572, 30098.69901300959, 30950.0, 31235.0, 31326.530102048942, 31424.371512570076, 37551.624483754815, 38283.61716382801, 41193.794031029654, 41279.1744165109, 41401.585984139776, 10148.79702405933, 10330.328528645614, 10344.896551034695, 10378.584856605652, 10526.0, 11030.889691103308, 11046.392448415414, 11067.72330691739, 11085.168612353944, 11452.599159029394, 9679.370840895319, 9742.95128524353, 9766.169875560658, 9814.558344874355, 10191.235657325878, 10086.394816311045, 10295.610092637398, 10316.587336506456, 10363.63727269542, 10369.688909332732, 10691.465426728788, 10903.236773425784, 11062.944685276843, 11359.716007099889, 11362.261453005529, 9143.451392916446, 9165.725028249164, 9383.953080234554, 9402.482863442576, 9570.425774453555, 8453.44177979778, 8469.661213551635, 8515.148485151436, 8558.57207139628, 8592.484450932963], "unit": "score", "name": "yui.html", "value": 5581.80340818242}], "name": "dromaeo_css", "value": 6161.78525025003}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 109.0, 113.0, 113.0, 113.0, 103.0, 112.0, 112.0, 106.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [152.0, 137.0, 147.0, 168.0, 132.0, 164.0, 158.0, 131.0, 172.0, 143.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 161.0, 163.0, 160.0, 159.0, 161.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 81.0, 92.0, 73.0, 72.0, 73.0, 99.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 146.0, 96.0, 97.0, 97.0, 139.0, 96.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 72.0, 81.0, 66.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.0}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [92.0, 84.0, 83.0, 84.0, 84.0, 83.0, 84.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [122.0, 125.0, 121.0, 121.0, 124.0, 121.0, 129.0, 122.0, 128.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [141.0, 148.0, 161.0, 151.0, 141.0, 142.0, 149.0, 148.0, 148.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 70.0, 69.0, 70.0, 69.0, 70.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1525.5999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.63406408094434], "unit": "score", "name": "Richards", "value": 209.34085999999994}, {"lowerIsBetter": false, "replicates": [187.82870022539444], "unit": "score", "name": "DeltaBlue", "value": 352.01223200000004}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1988.0715705765408], "unit": "score", "name": "RayTrace", "value": 372.21446699999984}, {"lowerIsBetter": false, "replicates": [804.0160642570281], "unit": "score", "name": "Earley", "value": 828.9175174825176}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [27270.27027027027], "unit": "score", "name": "RegExp", "value": 33.405792864221986}, {"lowerIsBetter": false, "replicates": [622.5124378109452], "unit": "score", "name": "Splay", "value": 130.9066213786214}, {"lowerIsBetter": false, "replicates": [4897.5609756097565], "unit": "score", "name": "NavierStokes", "value": 303.0079681274899}], "name": "v8_7", "value": 19579.70648588659}]} 19:28:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19579.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1525.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6161.79"}}} 19:28:36 INFO - Return code: 0 19:28:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:28:36 INFO - # TBPL SUCCESS # 19:28:36 INFO - Running post-action listener: _resource_record_post_action 19:28:36 INFO - Running post-run listener: _resource_record_post_run 19:28:37 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546095104; Read time: 16; Write time: 531468 19:28:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 228425728; Read time: 0; Write time: 282444 19:28:37 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317669376; Read time: 16; Write time: 249024 19:28:37 INFO - Running post-run listener: _upload_blobber_files 19:28:37 INFO - Blob upload gear active. 19:28:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:37 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 19:28:37 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'] 19:28:37 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 19:28:38 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:28:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:28:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:39 INFO - (blobuploader) - INFO - Done attempting. 19:28:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:28:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:28:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:39 INFO - (blobuploader) - INFO - Done attempting. 19:28:39 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:39 INFO - Return code: 0 19:28:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/58f84a9c742a945f29ff262e9e1df0122822a90a454e6ed9f82081fbea735f9d0793967f25ecbff7e58d1a6fa6b578273dd6aa3fb34cdd92a6b159f1d942e551", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/b2ed53ea75e8f4a7fecbd8b48c48f3f5f3911893fb4e1dd707e304ea25ff38da0b038d9527337a328c9da90af1f1577d31b0ee8452ce926dffcff475238ff385"} 19:28:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:39 INFO - Contents: 19:28:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/58f84a9c742a945f29ff262e9e1df0122822a90a454e6ed9f82081fbea735f9d0793967f25ecbff7e58d1a6fa6b578273dd6aa3fb34cdd92a6b159f1d942e551", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/b2ed53ea75e8f4a7fecbd8b48c48f3f5f3911893fb4e1dd707e304ea25ff38da0b038d9527337a328c9da90af1f1577d31b0ee8452ce926dffcff475238ff385"} 19:28:39 INFO - Copying logs to upload dir... 19:28:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.070349 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-25 19:28:39.647091) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 19:28:39.650526) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972 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/58f84a9c742a945f29ff262e9e1df0122822a90a454e6ed9f82081fbea735f9d0793967f25ecbff7e58d1a6fa6b578273dd6aa3fb34cdd92a6b159f1d942e551", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/b2ed53ea75e8f4a7fecbd8b48c48f3f5f3911893fb4e1dd707e304ea25ff38da0b038d9527337a328c9da90af1f1577d31b0ee8452ce926dffcff475238ff385"} build_url:https://queue.taskcluster.net/v1/task/EVWm9ngbQSeru8mdYqRw8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/EVWm9ngbQSeru8mdYqRw8g/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/58f84a9c742a945f29ff262e9e1df0122822a90a454e6ed9f82081fbea735f9d0793967f25ecbff7e58d1a6fa6b578273dd6aa3fb34cdd92a6b159f1d942e551", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/b2ed53ea75e8f4a7fecbd8b48c48f3f5f3911893fb4e1dd707e304ea25ff38da0b038d9527337a328c9da90af1f1577d31b0ee8452ce926dffcff475238ff385"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 19:28:39.675811) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:28:39.676167) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1451098964.280364-784106972 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:28:39.759040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 19:28:39.759356) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 19:28:39.759650) ========= ========= Total master_lag: 0.25 =========