builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1452183504.6 results: success (0) buildid: 20160107073325 builduid: f5ea7bfebda74c43a7615393229a7965 revision: 70b3481074b0085bb0c7b9a5ebc88c921a5055ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.597258) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.597701) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.598014) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006293 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.657051) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.657401) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.765477) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.765745) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.814240) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.814517) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.814887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.815158) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 08:18:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 43.6M=0s 2016-01-07 08:18:25 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157940 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.985153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:24.985504) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018521 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:25.036313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:25.036659) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 70b3481074b0085bb0c7b9a5ebc88c921a5055ec --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 70b3481074b0085bb0c7b9a5ebc88c921a5055ec --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=8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 08:18:25,554 truncating revision to first 12 chars 2016-01-07 08:18:25,554 Setting DEBUG logging. 2016-01-07 08:18:25,554 attempt 1/10 2016-01-07 08:18:25,554 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/70b3481074b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 08:18:25,796 unpacking tar archive at: b2g-inbound-70b3481074b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548408 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:25.602330) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:25.602671) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:25.613551) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:25.613946) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 08:18:25.614403) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-07 08:18:25.614683) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:18:26 INFO - MultiFileLogger online at 20160107 08:18:26 in /builds/slave/test 08:18:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 08:18:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:18:26 INFO - {'append_to_log': False, 08:18:26 INFO - 'base_work_dir': '/builds/slave/test', 08:18:26 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 08:18:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:18:26 INFO - 'branch': 'B2G-Inbound-Non-PGO', 08:18:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:26 INFO - 'config_files': ('talos/linux_config.py',), 08:18:26 INFO - 'default_actions': ('clobber', 08:18:26 INFO - 'read-buildbot-config', 08:18:26 INFO - 'download-and-extract', 08:18:26 INFO - 'populate-webroot', 08:18:26 INFO - 'create-virtualenv', 08:18:26 INFO - 'install', 08:18:26 INFO - 'run-tests'), 08:18:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:26 INFO - 'download_minidump_stackwalk': True, 08:18:26 INFO - 'download_symbols': 'ondemand', 08:18:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:26 INFO - 'installer_path': 'installer.exe', 08:18:26 INFO - 'log_level': 'info', 08:18:26 INFO - 'log_name': 'talos', 08:18:26 INFO - 'log_to_console': True, 08:18:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:18:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:18:26 INFO - 'opt_config_files': (), 08:18:26 INFO - 'pip_index': False, 08:18:26 INFO - 'sps_profile': False, 08:18:26 INFO - 'sps_profile_interval': 0, 08:18:26 INFO - 'suite': 'dromaeojs', 08:18:26 INFO - 'system_bits': '32', 08:18:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:26 INFO - 'title': 'talos-linux64-ix-041', 08:18:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:26 INFO - 'use_talos_json': True, 08:18:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:18:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:26 INFO - 'work_dir': 'build'} 08:18:26 INFO - ##### 08:18:26 INFO - ##### Running clobber step. 08:18:26 INFO - ##### 08:18:26 INFO - Running pre-action listener: _resource_record_pre_action 08:18:26 INFO - Running main action method: clobber 08:18:26 INFO - rmtree: /builds/slave/test/build 08:18:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:18:27 INFO - Running post-action listener: _resource_record_post_action 08:18:27 INFO - ##### 08:18:27 INFO - ##### Running read-buildbot-config step. 08:18:27 INFO - ##### 08:18:27 INFO - Running pre-action listener: _resource_record_pre_action 08:18:27 INFO - Running main action method: read_buildbot_config 08:18:27 INFO - Using buildbot properties: 08:18:27 INFO - { 08:18:27 INFO - "project": "", 08:18:27 INFO - "product": "firefox", 08:18:27 INFO - "script_repo_revision": "production", 08:18:27 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 08:18:27 INFO - "repository": "", 08:18:27 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 08:18:27 INFO - "buildid": "20160107073325", 08:18:27 INFO - "pgo_build": "False", 08:18:27 INFO - "basedir": "/builds/slave/test", 08:18:27 INFO - "buildnumber": 818, 08:18:27 INFO - "slavename": "talos-linux64-ix-041", 08:18:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:18:27 INFO - "platform": "ubuntu64_hw", 08:18:27 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 08:18:27 INFO - "branch": "b2g-inbound", 08:18:27 INFO - "repo_path": "integration/b2g-inbound", 08:18:27 INFO - "revision": "70b3481074b0085bb0c7b9a5ebc88c921a5055ec", 08:18:27 INFO - "stage_platform": "linux64", 08:18:27 INFO - "builduid": "f5ea7bfebda74c43a7615393229a7965", 08:18:27 INFO - "slavebuilddir": "test" 08:18:27 INFO - } 08:18:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:18:27 INFO - Running post-action listener: _resource_record_post_action 08:18:27 INFO - ##### 08:18:27 INFO - ##### Running download-and-extract step. 08:18:27 INFO - ##### 08:18:27 INFO - Running pre-action listener: _resource_record_pre_action 08:18:27 INFO - Running main action method: download_and_extract 08:18:27 INFO - mkdir: /builds/slave/test/build/tests 08:18: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')]} 08:18:27 INFO - https://queue.taskcluster.net/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:18:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/test_packages.json 08:18:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/test_packages.json 08:18:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:18:29 INFO - Downloaded 1302 bytes. 08:18:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:18:29 INFO - Using the following test package requirements: 08:18:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:18:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:29 INFO - u'jsshell-linux-x86_64.zip'], 08:18:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:18:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:18:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:18:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:18:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:18:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:29 INFO - https://queue.taskcluster.net/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:18:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/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 08:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/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 08:18:30 INFO - Downloaded 22787889 bytes. 08:18:30 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 08:18:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:30 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 08:18:31 INFO - Return code: 0 08:18:31 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 08:18:31 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')]} 08:18:31 INFO - https://queue.taskcluster.net/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:18:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/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 08:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/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 08:18:32 INFO - Downloaded 22787889 bytes. 08:18: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 08:18:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:18: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 08:18:34 INFO - Return code: 0 08:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:34 INFO - https://queue.taskcluster.net/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:18:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:18:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:18:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/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 08:18:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/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 08:18:35 INFO - Downloaded 11132285 bytes. 08:18: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 08:18:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:18: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 08:18:35 INFO - Return code: 0 08:18: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')]} 08:18:35 INFO - https://queue.taskcluster.net/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:18:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:18:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:18:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/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 08:18:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YEKrqUe9QjanEPq1IE7qtQ/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 08:18:36 INFO - Downloaded 54024044 bytes. 08:18:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:18:36 INFO - mkdir: /builds/slave/test/properties 08:18:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:18:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:18:36 INFO - Contents: 08:18:36 INFO - build_url:https://queue.taskcluster.net/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:18:36 INFO - Running post-action listener: _resource_record_post_action 08:18:36 INFO - Running post-action listener: set_extra_try_arguments 08:18:36 INFO - ##### 08:18:36 INFO - ##### Running populate-webroot step. 08:18:36 INFO - ##### 08:18:36 INFO - Running pre-action listener: _resource_record_pre_action 08:18:36 INFO - Running main action method: populate_webroot 08:18:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:18:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:18:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:18:36 INFO - '--tppagecycles', 08:18:36 INFO - '7'], 08:18:36 INFO - 'tests': ['tsvgm']}}, 08:18:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:18:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:18:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:18:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:18:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:18:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:18:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:36 INFO - 'talos_options': ['--e10s'], 08:18:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:36 INFO - 'tests': ['damp', 'tps']}, 08:18:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:36 INFO - 'talos_options': ['--e10s'], 08:18:36 INFO - 'tests': ['damp', 'tps']}, 08:18:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:18:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:18:36 INFO - 'other': {'tests': ['a11yr', 08:18:36 INFO - 'ts_paint', 08:18:36 INFO - 'tpaint', 08:18:36 INFO - 'sessionrestore', 08:18:36 INFO - 'sessionrestore_no_auto_restore']}, 08:18:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:18:36 INFO - 'tests': ['a11yr', 08:18:36 INFO - 'ts_paint', 08:18:36 INFO - 'tpaint', 08:18:36 INFO - 'sessionrestore', 08:18:36 INFO - 'sessionrestore_no_auto_restore']}, 08:18:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:18:36 INFO - 'tests': ['a11yr', 08:18:36 INFO - 'ts_paint', 08:18:36 INFO - 'tpaint', 08:18:36 INFO - 'sessionrestore', 08:18:36 INFO - 'sessionrestore_no_auto_restore']}, 08:18:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:18:36 INFO - 'tests': ['a11yr', 08:18:36 INFO - 'ts_paint', 08:18:36 INFO - 'tpaint', 08:18:36 INFO - 'sessionrestore', 08:18:36 INFO - 'sessionrestore_no_auto_restore']}, 08:18:36 INFO - 'other_l64': {'tests': ['a11yr', 08:18:36 INFO - 'ts_paint', 08:18:36 INFO - 'tpaint', 08:18:36 INFO - 'sessionrestore', 08:18:36 INFO - 'sessionrestore_no_auto_restore']}, 08:18:36 INFO - 'other_nol64': {'tests': ['a11yr', 08:18:36 INFO - 'ts_paint', 08:18:36 INFO - 'tpaint', 08:18:36 INFO - 'sessionrestore', 08:18:36 INFO - 'sessionrestore_no_auto_restore']}, 08:18:36 INFO - 'svgr': {'tests': ['tsvgx', 08:18:36 INFO - 'tsvgr_opacity', 08:18:36 INFO - 'tart', 08:18:36 INFO - 'tscrollx', 08:18:36 INFO - 'cart']}, 08:18:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:18:36 INFO - 'tests': ['tsvgx', 08:18:36 INFO - 'tsvgr_opacity', 08:18:36 INFO - 'tart', 08:18:36 INFO - 'tscrollx', 08:18:36 INFO - 'cart']}, 08:18:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:36 INFO - 'tests': ['tp5o']}, 08:18:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:36 INFO - 'talos_options': ['--e10s'], 08:18:36 INFO - 'tests': ['tp5o']}, 08:18:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:36 INFO - 'talos_options': ['--xperf_path', 08:18:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:36 INFO - 'tests': ['tp5n']}, 08:18:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:36 INFO - 'talos_options': ['--e10s', 08:18:36 INFO - '--xperf_path', 08:18:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:36 INFO - 'tests': ['tp5n']}}, 08:18:36 INFO - 'talos.zip': {'path': '', 08:18:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:18:36 INFO - Running post-action listener: _resource_record_post_action 08:18:36 INFO - ##### 08:18:36 INFO - ##### Running create-virtualenv step. 08:18:36 INFO - ##### 08:18:36 INFO - Running pre-action listener: _resource_record_pre_action 08:18:36 INFO - Running main action method: create_virtualenv 08:18:36 INFO - Creating virtualenv /builds/slave/test/build/venv 08:18:36 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 08:18:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:18:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:18:36 INFO - Using real prefix '/usr' 08:18:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:18:37 INFO - Installing distribute.............................................................................................................................................................................................done. 08:18:39 INFO - Installing pip.................done. 08:18:39 INFO - Return code: 0 08:18:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97531e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73d0>, '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 0x1022ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', '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 08:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:18:39 INFO - Using env: {'DISPLAY': ':0', 08:18:39 INFO - 'HOME': '/home/cltbld', 08:18:39 INFO - 'LANG': 'en_US.UTF-8', 08:18:39 INFO - 'LANGUAGE': 'en_US:en', 08:18:39 INFO - 'LOGNAME': 'cltbld', 08:18:39 INFO - 'MAIL': '/var/mail/cltbld', 08:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:39 INFO - 'MOZ_NO_REMOTE': '1', 08:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:39 INFO - 'NO_EM_RESTART': '1', 08:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:39 INFO - 'PWD': '/builds/slave/test', 08:18:39 INFO - 'SHELL': '/bin/bash', 08:18:39 INFO - 'SHLVL': '1', 08:18:39 INFO - 'TERM': 'linux', 08:18:39 INFO - 'TMOUT': '86400', 08:18:39 INFO - 'USER': 'cltbld', 08:18:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', 08:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:39 INFO - '_': '/tools/buildbot/bin/python'} 08:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:18:39 INFO - Cleaning up... 08:18:39 INFO - Return code: 0 08:18:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97531e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73d0>, '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 0x1022ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', '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 08:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:18:39 INFO - Using env: {'DISPLAY': ':0', 08:18:39 INFO - 'HOME': '/home/cltbld', 08:18:39 INFO - 'LANG': 'en_US.UTF-8', 08:18:39 INFO - 'LANGUAGE': 'en_US:en', 08:18:39 INFO - 'LOGNAME': 'cltbld', 08:18:39 INFO - 'MAIL': '/var/mail/cltbld', 08:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:39 INFO - 'MOZ_NO_REMOTE': '1', 08:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:39 INFO - 'NO_EM_RESTART': '1', 08:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:39 INFO - 'PWD': '/builds/slave/test', 08:18:39 INFO - 'SHELL': '/bin/bash', 08:18:39 INFO - 'SHLVL': '1', 08:18:39 INFO - 'TERM': 'linux', 08:18:39 INFO - 'TMOUT': '86400', 08:18:39 INFO - 'USER': 'cltbld', 08:18:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', 08:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:39 INFO - '_': '/tools/buildbot/bin/python'} 08:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:39 INFO - Downloading/unpacking psutil>=0.7.1 08:18:39 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 08:18:39 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 08:18:39 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 08:18:39 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 08:18:39 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 08:18:39 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 08:18:41 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:18:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:18:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:41 INFO - Installing collected packages: psutil 08:18:41 INFO - Running setup.py install for psutil 08:18:41 INFO - building 'psutil._psutil_linux' extension 08:18:41 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 08:18:41 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 08:18:41 INFO - building 'psutil._psutil_posix' extension 08:18:41 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 08:18:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:18:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:42 INFO - Successfully installed psutil 08:18:42 INFO - Cleaning up... 08:18:42 INFO - Return code: 0 08:18:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:18: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')]} 08:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18: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')]} 08:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97531e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73d0>, '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 0x1022ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', '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 08:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:18:42 INFO - Using env: {'DISPLAY': ':0', 08:18:42 INFO - 'HOME': '/home/cltbld', 08:18:42 INFO - 'LANG': 'en_US.UTF-8', 08:18:42 INFO - 'LANGUAGE': 'en_US:en', 08:18:42 INFO - 'LOGNAME': 'cltbld', 08:18:42 INFO - 'MAIL': '/var/mail/cltbld', 08:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:42 INFO - 'MOZ_NO_REMOTE': '1', 08:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:42 INFO - 'NO_EM_RESTART': '1', 08:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:42 INFO - 'PWD': '/builds/slave/test', 08:18:42 INFO - 'SHELL': '/bin/bash', 08:18:42 INFO - 'SHLVL': '1', 08:18:42 INFO - 'TERM': 'linux', 08:18:42 INFO - 'TMOUT': '86400', 08:18:42 INFO - 'USER': 'cltbld', 08:18:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', 08:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:42 INFO - '_': '/tools/buildbot/bin/python'} 08:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:18:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:18:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:18:44 INFO - Installing collected packages: mozsystemmonitor 08:18:44 INFO - Running setup.py install for mozsystemmonitor 08:18:44 INFO - Successfully installed mozsystemmonitor 08:18:44 INFO - Cleaning up... 08:18:44 INFO - Return code: 0 08:18:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97531e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73d0>, '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 0x1022ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', '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 08:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:18:44 INFO - Using env: {'DISPLAY': ':0', 08:18:44 INFO - 'HOME': '/home/cltbld', 08:18:44 INFO - 'LANG': 'en_US.UTF-8', 08:18:44 INFO - 'LANGUAGE': 'en_US:en', 08:18:44 INFO - 'LOGNAME': 'cltbld', 08:18:44 INFO - 'MAIL': '/var/mail/cltbld', 08:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:44 INFO - 'MOZ_NO_REMOTE': '1', 08:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:44 INFO - 'NO_EM_RESTART': '1', 08:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:44 INFO - 'PWD': '/builds/slave/test', 08:18:44 INFO - 'SHELL': '/bin/bash', 08:18:44 INFO - 'SHLVL': '1', 08:18:44 INFO - 'TERM': 'linux', 08:18:44 INFO - 'TMOUT': '86400', 08:18:44 INFO - 'USER': 'cltbld', 08:18:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', 08:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:44 INFO - '_': '/tools/buildbot/bin/python'} 08:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:44 INFO - Downloading/unpacking blobuploader==1.2.4 08:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:18:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:18:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:18:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:46 INFO - Downloading docopt-0.6.1.tar.gz 08:18:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:18:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:18:46 INFO - Running setup.py install for blobuploader 08:18:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:18:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:18:47 INFO - Running setup.py install for requests 08:18:47 INFO - Running setup.py install for docopt 08:18:47 INFO - Successfully installed blobuploader requests docopt 08:18:47 INFO - Cleaning up... 08:18:47 INFO - Return code: 0 08:18:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18: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')]} 08:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18: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')]} 08:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97531e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73d0>, '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 0x1022ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', '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 08:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:18:47 INFO - Using env: {'DISPLAY': ':0', 08:18:47 INFO - 'HOME': '/home/cltbld', 08:18:47 INFO - 'LANG': 'en_US.UTF-8', 08:18:47 INFO - 'LANGUAGE': 'en_US:en', 08:18:47 INFO - 'LOGNAME': 'cltbld', 08:18:47 INFO - 'MAIL': '/var/mail/cltbld', 08:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:47 INFO - 'MOZ_NO_REMOTE': '1', 08:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:47 INFO - 'NO_EM_RESTART': '1', 08:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:47 INFO - 'PWD': '/builds/slave/test', 08:18:47 INFO - 'SHELL': '/bin/bash', 08:18:47 INFO - 'SHLVL': '1', 08:18:47 INFO - 'TERM': 'linux', 08:18:47 INFO - 'TMOUT': '86400', 08:18:47 INFO - 'USER': 'cltbld', 08:18:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', 08:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:47 INFO - '_': '/tools/buildbot/bin/python'} 08:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:18:47 INFO - Running setup.py (path:/tmp/pip-CdNgUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:18:47 INFO - Running setup.py (path:/tmp/pip-660obq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:18:47 INFO - Running setup.py (path:/tmp/pip-0AgNgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:18:47 INFO - Running setup.py (path:/tmp/pip-42YWCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:18:48 INFO - Running setup.py (path:/tmp/pip-SrKc_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:18:48 INFO - Running setup.py (path:/tmp/pip-uTs3Qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:18:48 INFO - Running setup.py (path:/tmp/pip-TM_wL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:18:48 INFO - Running setup.py (path:/tmp/pip-QALUY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:18:48 INFO - Running setup.py (path:/tmp/pip-fszacA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:18:48 INFO - Running setup.py (path:/tmp/pip-rsxWnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:18:48 INFO - Running setup.py (path:/tmp/pip-25IvPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:18:48 INFO - Running setup.py (path:/tmp/pip-0WR5zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:18:48 INFO - Running setup.py (path:/tmp/pip-YF0B_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:18:48 INFO - Running setup.py (path:/tmp/pip-0I5jyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:48 INFO - Running setup.py (path:/tmp/pip-xvu75n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:18:48 INFO - Running setup.py (path:/tmp/pip-WlyfF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:18:48 INFO - Running setup.py (path:/tmp/pip-kH33tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:18:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:18:48 INFO - Running setup.py install for manifestparser 08:18:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Running setup.py install for mozcrash 08:18:49 INFO - Running setup.py install for mozdebug 08:18:49 INFO - Running setup.py install for mozdevice 08:18:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Running setup.py install for mozfile 08:18:49 INFO - Running setup.py install for mozhttpd 08:18:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Running setup.py install for mozinfo 08:18:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Running setup.py install for mozInstall 08:18:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Running setup.py install for mozleak 08:18:49 INFO - Running setup.py install for mozlog 08:18:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Running setup.py install for moznetwork 08:18:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Running setup.py install for mozprocess 08:18:50 INFO - Running setup.py install for mozprofile 08:18:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Running setup.py install for mozrunner 08:18:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Running setup.py install for mozscreenshot 08:18:50 INFO - Running setup.py install for moztest 08:18:50 INFO - Running setup.py install for mozversion 08:18:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:18:50 INFO - Cleaning up... 08:18:50 INFO - Return code: 0 08:18:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18: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')]} 08:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18: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')]} 08:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:50 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 0x7f97531e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73d0>, '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 0x1022ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', '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 08:18:50 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 08:18:50 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 08:18:50 INFO - Using env: {'DISPLAY': ':0', 08:18:50 INFO - 'HOME': '/home/cltbld', 08:18:50 INFO - 'LANG': 'en_US.UTF-8', 08:18:50 INFO - 'LANGUAGE': 'en_US:en', 08:18:50 INFO - 'LOGNAME': 'cltbld', 08:18:50 INFO - 'MAIL': '/var/mail/cltbld', 08:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:50 INFO - 'MOZ_NO_REMOTE': '1', 08:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:50 INFO - 'NO_EM_RESTART': '1', 08:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:50 INFO - 'PWD': '/builds/slave/test', 08:18:50 INFO - 'SHELL': '/bin/bash', 08:18:50 INFO - 'SHLVL': '1', 08:18:50 INFO - 'TERM': 'linux', 08:18:50 INFO - 'TMOUT': '86400', 08:18:50 INFO - 'USER': 'cltbld', 08:18:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', 08:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:50 INFO - '_': '/tools/buildbot/bin/python'} 08:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:18:50 INFO - Running setup.py (path:/tmp/pip-QPOudm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:18:51 INFO - Running setup.py (path:/tmp/pip-VlMsxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:18:51 INFO - Running setup.py (path:/tmp/pip-IZbhPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:18:51 INFO - Running setup.py (path:/tmp/pip-W9qcTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:18:51 INFO - Running setup.py (path:/tmp/pip-Ai1jCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:18:51 INFO - Running setup.py (path:/tmp/pip-jYKQV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:18:51 INFO - Running setup.py (path:/tmp/pip-iQpsJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:18:51 INFO - Running setup.py (path:/tmp/pip-KUqyAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:18:51 INFO - Running setup.py (path:/tmp/pip-rZLhvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:18:51 INFO - Running setup.py (path:/tmp/pip-YrocyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:18:51 INFO - Running setup.py (path:/tmp/pip-c220Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:18:51 INFO - Running setup.py (path:/tmp/pip-_RWwmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:18:51 INFO - Running setup.py (path:/tmp/pip-JzWlqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:18:51 INFO - Running setup.py (path:/tmp/pip-L7YBU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:51 INFO - Running setup.py (path:/tmp/pip-pD6e1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:18:52 INFO - Running setup.py (path:/tmp/pip-Rg7G7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:18:52 INFO - Running setup.py (path:/tmp/pip-Mv2klU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:18:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:53 INFO - Downloading blessings-1.5.1.tar.gz 08:18:53 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 08:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:18:53 INFO - Installing collected packages: blessings 08:18:53 INFO - Running setup.py install for blessings 08:18:54 INFO - Successfully installed blessings 08:18:54 INFO - Cleaning up... 08:18:54 INFO - Return code: 0 08:18:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:18:54 INFO - Reading from file tmpfile_stdout 08:18:54 INFO - Current package versions: 08:18:54 INFO - argparse == 1.2.1 08:18:54 INFO - blessings == 1.5.1 08:18:54 INFO - blobuploader == 1.2.4 08:18:54 INFO - docopt == 0.6.1 08:18:54 INFO - manifestparser == 1.1 08:18:54 INFO - mozInstall == 1.12 08:18:54 INFO - mozcrash == 0.16 08:18:54 INFO - mozdebug == 0.1 08:18:54 INFO - mozdevice == 0.47 08:18:54 INFO - mozfile == 1.2 08:18:54 INFO - mozhttpd == 0.7 08:18:54 INFO - mozinfo == 0.9 08:18:54 INFO - mozleak == 0.1 08:18:54 INFO - mozlog == 3.1 08:18:54 INFO - moznetwork == 0.27 08:18:54 INFO - mozprocess == 0.22 08:18:54 INFO - mozprofile == 0.28 08:18:54 INFO - mozrunner == 6.11 08:18:54 INFO - mozscreenshot == 0.1 08:18:54 INFO - mozsystemmonitor == 0.0 08:18:54 INFO - moztest == 0.7 08:18:54 INFO - mozversion == 1.4 08:18:54 INFO - psutil == 3.1.1 08:18:54 INFO - requests == 1.2.3 08:18:54 INFO - wsgiref == 0.1.2 08:18:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97531e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73d0>, '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 0x1022ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', '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 08:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:18:54 INFO - Using env: {'DISPLAY': ':0', 08:18:54 INFO - 'HOME': '/home/cltbld', 08:18:54 INFO - 'LANG': 'en_US.UTF-8', 08:18:54 INFO - 'LANGUAGE': 'en_US:en', 08:18:54 INFO - 'LOGNAME': 'cltbld', 08:18:54 INFO - 'MAIL': '/var/mail/cltbld', 08:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:54 INFO - 'MOZ_NO_REMOTE': '1', 08:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:54 INFO - 'NO_EM_RESTART': '1', 08:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:54 INFO - 'PWD': '/builds/slave/test', 08:18:54 INFO - 'SHELL': '/bin/bash', 08:18:54 INFO - 'SHLVL': '1', 08:18:54 INFO - 'TERM': 'linux', 08:18:54 INFO - 'TMOUT': '86400', 08:18:54 INFO - 'USER': 'cltbld', 08:18:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', 08:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:54 INFO - '_': '/tools/buildbot/bin/python'} 08:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:18:54 INFO - Cleaning up... 08:18:54 INFO - Return code: 0 08:18:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f97531e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73d0>, '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 0x1022ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', '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 08:18:54 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 08:18:54 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 08:18:54 INFO - Using env: {'DISPLAY': ':0', 08:18:54 INFO - 'HOME': '/home/cltbld', 08:18:54 INFO - 'LANG': 'en_US.UTF-8', 08:18:54 INFO - 'LANGUAGE': 'en_US:en', 08:18:54 INFO - 'LOGNAME': 'cltbld', 08:18:54 INFO - 'MAIL': '/var/mail/cltbld', 08:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:54 INFO - 'MOZ_NO_REMOTE': '1', 08:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:54 INFO - 'NO_EM_RESTART': '1', 08:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:54 INFO - 'PWD': '/builds/slave/test', 08:18:54 INFO - 'SHELL': '/bin/bash', 08:18:54 INFO - 'SHLVL': '1', 08:18:54 INFO - 'TERM': 'linux', 08:18:54 INFO - 'TMOUT': '86400', 08:18:54 INFO - 'USER': 'cltbld', 08:18:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', 08:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:54 INFO - '_': '/tools/buildbot/bin/python'} 08:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:54 INFO - Downloading/unpacking jsonschema 08:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:18:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:18:56 INFO - Downloading/unpacking functools32 (from jsonschema) 08:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:56 INFO - Downloading functools32-3.2.3-2.tar.gz 08:18:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:18:56 INFO - warning: no files found matching '*.txt' 08:18:56 INFO - no previously-included directories found matching 'build' 08:18:56 INFO - no previously-included directories found matching 'dist' 08:18:56 INFO - no previously-included directories found matching '.git*' 08:18:56 INFO - Installing collected packages: jsonschema, functools32 08:18:56 INFO - Running setup.py install for functools32 08:18:56 INFO - warning: no files found matching '*.txt' 08:18:56 INFO - no previously-included directories found matching 'build' 08:18:56 INFO - no previously-included directories found matching 'dist' 08:18:56 INFO - no previously-included directories found matching '.git*' 08:18:56 INFO - Successfully installed jsonschema functools32 08:18:56 INFO - Cleaning up... 08:18:56 INFO - Return code: 0 08:18:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:18:56 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')]} 08:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:56 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')]} 08:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:56 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 0x7f97531e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73d0>, '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 0x1022ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023360>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', '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 08:18:56 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 08:18:56 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 08:18:56 INFO - Using env: {'DISPLAY': ':0', 08:18:56 INFO - 'HOME': '/home/cltbld', 08:18:56 INFO - 'LANG': 'en_US.UTF-8', 08:18:56 INFO - 'LANGUAGE': 'en_US:en', 08:18:56 INFO - 'LOGNAME': 'cltbld', 08:18:56 INFO - 'MAIL': '/var/mail/cltbld', 08:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:56 INFO - 'MOZ_NO_REMOTE': '1', 08:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:56 INFO - 'NO_EM_RESTART': '1', 08:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:56 INFO - 'PWD': '/builds/slave/test', 08:18:56 INFO - 'SHELL': '/bin/bash', 08:18:56 INFO - 'SHLVL': '1', 08:18:56 INFO - 'TERM': 'linux', 08:18:56 INFO - 'TMOUT': '86400', 08:18:56 INFO - 'USER': 'cltbld', 08:18:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', 08:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:56 INFO - '_': '/tools/buildbot/bin/python'} 08:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:57 INFO - Downloading/unpacking flake8 08:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:18:58 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 08:18:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:18: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 08:18: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 08:18: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 08:18: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 08:18: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 08:18: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 08:18:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:18:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:18:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:18: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 08:18: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 08:18: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 08:18: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 08:18: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 08:18: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 08:18:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:18:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:18: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 08:18: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 08:18: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 08:18: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 08:18: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 08:18: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 08:18:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:18:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:18:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:18:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:18:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:18:59 INFO - no previously-included directories found matching 'docs/_build' 08:18:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:18:59 INFO - Running setup.py install for pep8 08:18:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:18:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:18:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:18:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:18:59 INFO - no previously-included directories found matching 'docs/_build' 08:18:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:18:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:18:59 INFO - Cleaning up... 08:18:59 INFO - Return code: 0 08:18:59 INFO - Running post-action listener: _resource_record_post_action 08:18:59 INFO - Running post-action listener: _start_resource_monitoring 08:18:59 INFO - Starting resource monitoring. 08:18:59 INFO - ##### 08:18:59 INFO - ##### Running install step. 08:18:59 INFO - ##### 08:18:59 INFO - Running pre-action listener: _resource_record_pre_action 08:18:59 INFO - Running main action method: install 08:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:18:59 INFO - Reading from file tmpfile_stdout 08:18:59 INFO - Detecting whether we're running mozinstall >=1.0... 08:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:19:00 INFO - Reading from file tmpfile_stdout 08:19:00 INFO - Output received: 08:19:00 INFO - Usage: mozinstall [options] installer 08:19:00 INFO - Options: 08:19:00 INFO - -h, --help show this help message and exit 08:19:00 INFO - -d DEST, --destination=DEST 08:19:00 INFO - Directory to install application into. [default: 08:19:00 INFO - "/builds/slave/test"] 08:19:00 INFO - --app=APP Application being installed. [default: firefox] 08:19:00 INFO - mkdir: /builds/slave/test/build/application 08:19:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:19:15 INFO - Reading from file tmpfile_stdout 08:19:15 INFO - Output received: 08:19:15 INFO - /builds/slave/test/build/application/firefox/firefox 08:19:15 INFO - Running post-action listener: _resource_record_post_action 08:19:15 INFO - ##### 08:19:15 INFO - ##### Running run-tests step. 08:19:15 INFO - ##### 08:19:15 INFO - Running pre-action listener: _resource_record_pre_action 08:19:15 INFO - Running main action method: run_tests 08:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:19:15 INFO - Python 2.7.3 08:19:15 INFO - Return code: 0 08:19:15 INFO - grabbing minidump binary from tooltool 08:19:15 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')]} 08:19:15 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 0x10b73d0>, '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 0x1022ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:19:15 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 08:19:15 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 08:19:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:19:15 INFO - Return code: 0 08:19:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:19:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:19:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:19:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:19:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:19:16 INFO - Return code: 0 08:19:16 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/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 08:19:16 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/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 08:19:16 INFO - Using env: {'DISPLAY': ':0', 08:19:16 INFO - 'HOME': '/home/cltbld', 08:19:16 INFO - 'LANG': 'en_US.UTF-8', 08:19:16 INFO - 'LANGUAGE': 'en_US:en', 08:19:16 INFO - 'LOGNAME': 'cltbld', 08:19:16 INFO - 'MAIL': '/var/mail/cltbld', 08:19:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:19:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:16 INFO - 'MOZ_NO_REMOTE': '1', 08:19:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:16 INFO - 'NO_EM_RESTART': '1', 08:19:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:16 INFO - 'PWD': '/builds/slave/test', 08:19:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:19:16 INFO - 'SHELL': '/bin/bash', 08:19:16 INFO - 'SHLVL': '1', 08:19:16 INFO - 'TERM': 'linux', 08:19:16 INFO - 'TMOUT': '86400', 08:19:16 INFO - 'USER': 'cltbld', 08:19:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654', 08:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:16 INFO - '_': '/tools/buildbot/bin/python'} 08:19:16 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/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 08:19:17 INFO - mozversion application_buildid: 20160107073325 08:19:17 INFO - mozversion application_changeset: 70b3481074b0085bb0c7b9a5ebc88c921a5055ec 08:19:17 INFO - mozversion application_display_name: Nightly 08:19:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:19:17 INFO - mozversion application_name: Firefox 08:19:17 INFO - mozversion application_remotingname: firefox 08:19:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 08:19:17 INFO - mozversion application_vendor: Mozilla 08:19:17 INFO - mozversion application_version: 46.0a1 08:19:17 INFO - mozversion platform_buildid: 20160107073325 08:19:17 INFO - mozversion platform_changeset: 70b3481074b0085bb0c7b9a5ebc88c921a5055ec 08:19:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 08:19:17 INFO - mozversion platform_version: 46.0a1 08:19:17 INFO - using testdate: 1452183557 08:19:17 INFO - actual date: 1452183557 08:19:17 INFO - starting webserver on 'localhost:46602' 08:19:17 INFO - SUITE-START | Running 3 tests 08:19:17 INFO - TEST-START | dromaeo_css 08:19:17 INFO - operating with platform_type : linux_ 08:19:17 INFO - Initialising browser for dromaeo_css test... 08:19:17 INFO - TEST-INFO | started process 13937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiPSUn2/profile http://localhost:46602/getInfo.html) 08:19:21 INFO - PROCESS | 13937 | __metrics Screen width/height:1600/1200 08:19:21 INFO - PROCESS | 13937 | colorDepth:24 08:19:21 INFO - PROCESS | 13937 | Browser inner width/height: 1024/697 08:19:21 INFO - PROCESS | 13937 | __metrics 08:19:21 INFO - PROCESS | 13937 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:19:21 INFO - PROCESS | 13937 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:22 INFO - TEST-INFO | 13937: exit 0 08:19:22 INFO - Browser initialized. 08:19:22 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:22 INFO - TEST-INFO | started process 14030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiPSUn2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:34 INFO - PROCESS | 14030 | RSS: Main: 150163456 08:19:34 INFO - PROCESS | 14030 | 08:20:26 INFO - PROCESS | 14030 | 1452183626085 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] 08:22:38 INFO - PROCESS | 14030 | Cycle 1(1): loaded http://localhost:46602/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46602/tests/dromaeo/cssquery-ext.html) 08:22:39 INFO - PROCESS | 14030 | RSS: Main: 235630592 08:22:39 INFO - PROCESS | 14030 | 08:25:41 INFO - PROCESS | 14030 | Cycle 1(1): loaded http://localhost:46602/tests/dromaeo/cssquery-ext.html (next: http://localhost:46602/tests/dromaeo/cssquery-jquery.html) 08:25:42 INFO - PROCESS | 14030 | RSS: Main: 224628736 08:25:42 INFO - PROCESS | 14030 | 08:28:44 INFO - PROCESS | 14030 | Cycle 1(1): loaded http://localhost:46602/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46602/tests/dromaeo/cssquery-mootools.html) 08:28:45 INFO - PROCESS | 14030 | RSS: Main: 218079232 08:28:45 INFO - PROCESS | 14030 | 08:31:46 INFO - PROCESS | 14030 | Cycle 1(1): loaded http://localhost:46602/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46602/tests/dromaeo/cssquery-prototype.html) 08:31:47 INFO - PROCESS | 14030 | RSS: Main: 212320256 08:31:47 INFO - PROCESS | 14030 | 08:34:50 INFO - PROCESS | 14030 | Cycle 1(1): loaded http://localhost:46602/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46602/tests/dromaeo/cssquery-yui.html) 08:34:50 INFO - PROCESS | 14030 | RSS: Main: 214503424 08:34:50 INFO - PROCESS | 14030 | 08:37:53 INFO - PROCESS | 14030 | Cycle 1(1): loaded http://localhost:46602/tests/dromaeo/cssquery-yui.html (next: http://localhost:46602/tests/dromaeo/cssquery-dojo.html) 08:37:53 INFO - PROCESS | 14030 | RSS: Main: 259842048 08:37:53 INFO - PROCESS | 14030 | 08:37:53 INFO - PROCESS | 14030 | __start_tp_report 08:37:53 INFO - PROCESS | 14030 | _x_x_mozilla_page_load 08:37:53 INFO - PROCESS | 14030 | _x_x_mozilla_page_load_details 08:37:53 INFO - PROCESS | 14030 | |i|pagename|runs| 08:37:53 INFO - PROCESS | 14030 | |0;dojo.html;2551.3111459905826;2668.3329167708075;2671.666041744782;2682.342826007628;2684.5167869783445;4365.563443655633;4508.165989291975;4571.2914498252785;4623.722576645404;4638.420197475316;4500.1674690182335;4527.09458108378;4622.630189584834;4634.3511908332775;4634.791434385453;4052.9797351013203;4137.180185084383;4186.099988502471;4231.70378073535;4292.860300728722;4239.08859595187;4306.61240488356;4309.719868208572;4312.22379971605;4338.414314067592;4101.323281658538;4140.23405669952;4224.112936283384;4232.640225580829;4245.596668316505;4227.534971153171;4250.808713607895;4259.61663450291;4268.679849011305;4286.099919016979;4226.535081141072;4236.428082208893;4238.258304796679;4245.596668316505;4279.229738647043;4320.481542214954;4448.7108337957925;4452.710573812724;4464.776761161929;4600.033992861503;4871.658983871131;4905.705657660552;4910.90178196434;4912.115819152551;4951.8266860659705;4927.6550641455115;4928.408590969071;4932.679375840559;4933.45731969483;4935.432425271104;4401.361802538646;4487.439070116236;4512.481064677604;4517.593416592523;4520.2315606347;4951.678140920901;4989.351384320015;4991.975040124777;5004.074246264453;5032.32063671407;4797.18447863864;4797.496262892416;4804.015176888729;4804.711717296974;4849.80600775965;4723.574878260904;4865.854024379274;4870.659053866196;4871.902561948741;4883.51164883516;4756.167670657621;4761.285807128958;4807.254875494304;4840.056189043174;4879.121758083579;4834.371531700926;4840.394950631171;4848.418189817174;4848.490908454632;4911.263310503382;3886.1839013807416;4027.8791636250958;4049.919001619951;4055.026793569581;4088.693347998912;3500.754947153675;3545.503629491873;3584.928301434009;3596.7841929484316;3613.4218525035867;4214.346776249687;4244.02387450888;4247.405363249148;4252.213340532012;4282.314829627245;4755.619550435957;4872.293517439952;4916.385451818523;4929.841487250494;4974.37820272466;4160.729552579072;4167.395727619478;4184.958150418457;4231.492220933507;4289.03496713237;4299.613034826881;4305.182015417061;4309.698321117555;4314.288142456522;4351.303791393425;4648.25627899548;4651.488336283074;4653.092646933883;4653.860384188412;4685.882852928636;4694.577488026094;4810.5670489656095;4810.7113573185725;4819.445763737075;4907.288443175791;4690.788914498788;4691.953080469151;4692.389989301369;4711.528847115261;4734.242521196592;4823.927641085316;4826.58973987215;4842.394700662418;4890.850650097295;4892.3884514435695;4763.499832517536;4873.634477414137;4878.121938051185;4903.31353610502;4918.040982008474;4637.489876113557;4726.6455015874635;4732.100900828831;4735;4779.139754844162;4752.120857641347;4753.191957367187;4753.667243292936;4777.235642297216;4796.232602783538;4448.288273876165;4546.477155127071;4554.635629149594;4585.931211031904;4641.373414589122;4766.356541866804;4821.686590371614;4836.226203807374;4839.056384005085;4878.609711223165;4622.075584882969;4625.629949604091;4632.8146874126005;4633.05022470386;4672.976635116803 08:37:53 INFO - PROCESS | 14030 | |1;ext.html;480.50027970910253;481.2516536785302;502.07868561190213;505.6637336171446;530.5940955169297;24530.141445049427;24943.25170244893;32288;32523.67476325242;32543.67456325436;35602;36009.27981440369;36072.81963590178;36150.276994460095;36156.638433615655;6721.193456785192;6847.281035491276;7563.508371955832;7729.072511298624;7748.883766743504;9579.712608621718;9775.31572789905;9798.510074496282;9801.705948821547;9846.458444785534;9521.857172142423;9629.614815407374;9629.614815407374;9630.711078667651;9641.61433542661;9437.622495100188;9487;9523.904760952371;9531.046895310448;9533.713988580354;9376.109269619375;9525.237831001286;9528.857067143997;9529.237660987104;9535.761605959837;34659;34996.200303975624;34997.47503787445;35008;35055.82472087623;2761.144045345949;2761.4615150045747;2781.694013658496;3358.9496157557655;3562.3029451758207;23765.643515347285;24747.25758227256;27835.86082069597;28059.15822525307;28137.718622813714;3037.817730936151;3049.618797650294;3069.8772049118234;3098.086064610945;3128.311771410286;171040.14479927646;175515;175936;176245.11877440658;176329;45316.320255196195;46341.768291159;49641;49948;54126;48502.27246591304;48509.75745121252;48852.511474885505;48870.26694599584;48994.51005489971;12244.387780610934;12483.438245278985;12493.687657808627;12506.749865002648;12509;9315.813683726288;9339.813203735886;9370.625174992923;9381.577828997712;9390.201832844148;17628.471145865646;18500.35248766287;18572.535686607942;18652.44042678722;18659.81340186581;7359.521631093961;7660.502067365604;7705.30652241301;7726.38188944883;7750.605750256062;827.4538804389074;871.0679572856982;875.7285241575132;894.6742500012383;981.499435287994;27719.168424947286;28705;29293.414131717247;29332.97334593279;29424.705752942198;900.4642237868458;941.7316064921464;1016.3139880580578;1080.7892460970036;1098.780243951213;13545.525906593222;13580;14093.2248726319;14093.365798539091;14101.78847317291;286580;290286;291164;292052;292921;45605.54394456079;46123.53876461193;46128;46157;46224.07551849011;1159.7970355187808;1173.5657806611437;1196.4017991004498;1200.8919197272112;1202.5310129049678;20837.270695525585;25529.23412297634;26386.34034149085;26691.466170676867;26826.19521414361;38926.80536597299;39395;39559.60440395674;39591.80204098961;39649.603503964594;241225;244548;244718;245480;245610;23735.762642373356;24276.1503347382;28456.288592785346;28986;29043.85478072596;32226.194345140622;32369.676303236665;32441.35117297688;40870.1825963485;42166.789166053975;29212.853935730185;29939.401211976074;30010;30460.39079218359;30587.847060764554;29337.55993660054;29980.550291745207;30046.399072018;30177.698223017487;30267.09198724042;30388;35091.82454087713;35564.822175888956;35693.1076723084;35733.64266357303;25770.35574110662;29356.119316420543;29692.703072968994;29722.405551889275;29867.402651947275;22991.65512517347;23007.309780706604;23088.53822923566;23290.53418931646;23320.533589328457 08:37:53 INFO - PROCESS | 14030 | |2;jquery.html;311.30734116590577;324.005303717587;325.1740578929519;326.7320796946505;327.7738360531233;12389.256644601308;12747.043971702136;15330.23348832558;15721.13533755643;15964.441244556443;12501.124921255516;14817.259137043158;15499.612509687235;16224.10767407792;16266.83733162668;4834.564889159966;4939.703617782927;5045.646804723652;5103.770330335125;5105.4128775190775;3512.1921957949558;3606.945895811565;4952.752362381884;5121.257417674435;5191.506806853343;5041.067402530525;5067.898642027158;5071.442141364447;5095.464976177485;5096.719680417576;5061.19020956647;5064.3163172971545;5221.39953905302;5670.3479099903625;5692.0608099663505;5045.798168073273;5051.06555287273;5054.721990290533;5055.11535481293;5058.494150584949;10547.578096876192;14681.926590367086;18580.535486612807;18944;18998.24007039717;1725.6376161006203;1755.3242001829387;1777.6089260362698;1778.1020584604692;1875.268645228362;8320.167983201693;8434.662613495453;8497.235248827574;8550.10223926485;8670.263027642657;1708.709519381708;1756.3852651571976;1759.472158352502;1773.9976913044088;1783.7502749615064;53009;55824.72087639577;55978.72010639962;56269.43730562724;57525.424745752425;8980.697798819134;9112.271018318519;9119.954400227956;9173.174414302612;9186.724398267928;11457.484413201259;11491.942540287246;11500.827487587692;11504.827427588592;11510.942445287887;6377.840553986095;6421.2615549211505;6459.773907913201;6488.156539649815;6493.123428337114;6176.135341052256;6188.381161883775;6214.533909956771;6238.189035425366;6252.874942501125;3771.7548359356556;3831.5210598675167;3837.865674701372;3890.8832735017995;3966.504186976628;1467.7504824179914;1552.534239728077;1586.1593355521593;1625.617979774752;1630.7524743571178;347.598523705121;350.14913759563996;367.5497515543438;379.2528718424699;769.6075001749036;9070.81858362829;9388.342816002814;9647.517624118766;9656.855147172657;9773.609055637837;351.72038229607523;355.0666620252699;368.5761374419439;369.0349735441854;374.5206136145738;4723.527647235249;5008.84973450797;5049.8737531562;5077.492250774893;5116.181410974301;452887;457548;457908;458571;459967;66054.33945660578;69935.65032174806;69994;70054.64972675104;70316;417.53444908926326;422.2210022508467;422.97462152270964;423.1135770560671;423.25084600257986;8940.642374304955;8950.641974320954;8952.194302512544;9013.324000699842;9203.677871274473;28749;29286.707132928397;30499.390012200074;30668.693313066582;32690.346193076482;38736.61263387443;40800.79599601983;41848;43074;43831.561684382745;7977.880331795144;8076.313513351431;8165.061017983008;8167.0607880092175;8198.098209196864;15168.544943651708;15404.229788510755;15426.691466170838;15679.29443175037;16056.277467514223;13098.083134180515;13416.396262168031;13467.259300738162;13806.447742090606;13832.100913440594;12777.16948398351;12831.486740530274;13022.674433139247;13435.059545831698;13435.328233588478;11113.110951124052;13370.732585348043;13914;13936.512222072179;14096.295185240491;7080;8141.348692104736;8261.09127995932;8365.498070115813;8387.790305242417;9124.771880703036;12622.747545049231;13259.80110298327;13366.665833354244;13828.30858457053 08:37:53 INFO - PROCESS | 14030 | |3;mootools.html;1132.8130858408363;1311.855116883895;1327.6680829792551;1385.972280554389;1672.4230140601487;5746.569007324451;6440.806775796727;6567.901481477782;6574.605523668572;6590.242122155947;6431.485481161508;6608.933910660904;6613.636250006248;6614.3716346947085;6615.503837212204;1966.459223713476;1993.252530301137;1994.3917105282883;1995.7704863940687;1997.2410484016054;1961.8234358907696;2024.787397323282;2027.8276346510565;2031.7155598216261;2047.119738512439;1969.2812123574936;2007.6687346587796;2031.3195079648262;2031.4819720971132;2033.6136134134467;1991.790861959495;2010.9195632174697;2014.969775453362;2015.7883422240673;2017.8890161041136;1953.736245606839;1966.7246585478044;1966.9213231470724;1985.7319261899604;1985.9702104468445;6625.5693379930635;6626.7017984190825;6654.800355989328;6677.766278180289;6696.732130714766;3736.5142531470733;3780.8676696315497;3794.677452416548;3800.391937290048;3806.3148633246005;2614.3202767280454;2641.9207423777316;2668.3329167708075;2687.9731202688113;2711.7830573554265;888.9911100888972;898.5148020069155;907.5961197267219;912.2519533982137;920.1166879795404;8831.425957312755;8918.464892106495;8946;8959.41763785352;8960.8655870162;3453.6546345365264;3460.567429071366;3519.1378112362636;3543.805090720035;3556.4665300205174;7714.3442807362;7784.649690763929;7801.45389822707;7808.141104478503;7829.099653539802;3854.5567259764925;3861;3861.4400911868183;3863.16941857502;3866.5360156781367;3133.89031383905;3204.471262241704;3500.544929159193;3573.874914377984;3581.7492775505984;3174.492081266986;3180.840957952093;3211.550382946343;3243.675632436785;3253.2354896599754;993.101243374747;1010.1767059846202;1014.2697257974247;1027.337367398039;1027.6557353286732;1125.094299089241;1146.4382452598168;1149.436775979764;1155.179822326141;1176.3765204441659;6185.505159587222;6290.150829638032;6385.904211436832;6386.712597933104;6397.232332120082;394.9822257998397;398.7288643722239;400.4553806822719;401.17358242021527;401.33979603552575;5046.798128074909;5109.054824857413;5117.948820511821;5121.078205922895;5122.385313762298;7083.858322833617;7286.089238845145;7851.29338359539;8022.358211343078;8030.879536806952;7811.4922530035365;7897.565633890191;7918.168592297726;7928.088269848926;7945.205479452008;6144.201253837062;6266.561340706106;6268.028455589391;6289.24529056507;6299.370062993664;5933.080372542263;5942.881142377042;6053.122297266959;6060.090986352083;6079.848003799941;6862.588244705334;6908.689108990208;7125.572465652078;7127.643617819192;7179.784606461814;7006.75476358325;7301.890471642823;7306.926930730625;7320.597367144858;7389.741359052622;5430.70131142791;5542.972285138549;6142.078688196806;6216.595921265103;6217.658028808459;6127.050307202391;6246.843828904313;6274;6279.335975966281;6293.370662933853;5878.29460464747;5907.645541267538;5928.584999050025;6062.878742425215;6199;5932.2584676915385;6024.849378765566;6043.3050199227655;6092.390760923872;6126.387361264016;5726.856828579319;5839.240898683144;5850.882982340415;5855.736491857791;6074.0281554951;5566.638168519034;5589.664620122806;5603.775848966159;5615.522680572197;5643.943560564342;5572.331320241597;5616.634918730269;5636.351819540805;5640.492355688008;5641.40765219646 08:37:53 INFO - PROCESS | 14030 | |4;prototype.html;284.9886004559818;288.8180446318819;290.86620154728837;294.15577293168604;295.91418488638294;5299.708516031616;5357.357117145938;5367.892642147155;5377.892442151155;5404.108322126849;5048.3437153170125;5118.564921981636;5236.188390799422;5274;5281.207818827178;4120.711550191488;4123.60825721556;4124.711270211086;4129.29801933672;4132.111596006858;3853.0945227871566;4120.217158739845;4121.793910304487;4126.938095928564;4127.2570937231285;3876.8643097491595;3933.704972127088;4011.3581826907703;4021.939670904939;4026.9529922220286;4029.758214507124;4071.2061148076136;4072.287349713818;4074.5925407459313;4091.9795401022952;3599.766015209003;3604.1530240393486;3604.981975090134;3614.8554057837655;3617.457381392786;5107.463716309809;5116.155834287338;5129.1024070787835;5131.743412829381;5140.511651393112;4618.976905115453;4714.787834547454;4719.056188762227;4721.102990431807;4731.550502702238;5550.888982220333;5554.888902221974;5559.277293951801;5561.443855614447;5564.304461942257;3934.429507721364;3936.744111632763;3937.2912875682364;3938.921221575581;3944.408338749182;5832.999999999957;5833.32916714579;5844.064949608042;5845.532357411397;5846.883062338729;3970.662493688011;4055.3511438169753;4063.227986682521;4065.8780236592947;4090.8568200112854;4089.0595163112653;4098.631123198927;4128.649064829463;4134.049168691157;4134.4831896013;4637.837675681335;4637.95362046382;4643.349931009661;4680.742559159211;4696.272077827942;5536.778528858881;5557.888422315553;5586.525145362609;5587.888242235133;5588.2455868458055;1419.8296204455532;1424.893133015028;1447.623617859343;1455.7088582283586;1463.2025546077414;969.486172328667;987.2940847294219;998.9150922171551;1007.4610083605236;1008.9445080520642;4888.877778055577;4896.387951506062;4899.804007839646;4906.435759887659;4914.778834952435;5783.537317014629;5788.710564471759;5796;5808.912866307009;5809.912851307234;4698.671093023456;4791.209450440708;4800.855974320776;4893.951060489349;4944.579710724557;3111.2066423061974;3135.937281254362;3139.0896639974153;3153.8896138635037;3155.952660710045;5491.752871120809;5509.807156749494;5523.6409633373705;5525.696086715269;5533.446655334515;5961.076033214858;5977.521798256129;5979.342272350038;5980;5986.551008674367;5368.489993450616;5524.226608274845;5540.030494663418;5551.361593416728;5556.499915007668;5772.105323674838;5846.573671926273;5858.853528661817;5863.091220860773;5871.647701137946;5705.115707065412;5721.342045664802;5722.742476588647;5723.3418156912485;5724.398938111605;5351.973240133774;5511.641743286674;5541.750621221974;5550.944490555043;5553.0837411828215;3984.960150398575;4028.073543085048;4030.2141082488633;4031.012401961538;4034.8991275218355;5792.073268277056;5795.797147099831;5796.884062318814;5802.332731735904;5805.10020946754;5556.277683901067;5597.692126933058;5599.076152434803;5599.748011339418;5602.0196465619165;5424.457554244544;5550.139728342114;5601.131824567198;5640.153976903333;5647.463490968352;5439.891202176013;5467.45325467466;5474.233607295061;5475.753591088331;5481.479259470344;5669.433056694463;5670.546356291405;5675.091985282335;5683.119116536944;5694.658320500783;5353.304070470814;5411.458854114557;5470.398256191736;5487.204355368529;5493.121100623881 08:37:53 INFO - PROCESS | 14030 | |5;yui.html;770.4799260499161;784.4626430894841;789.5933594198989;799.4084377560607;800.0439474827582;11593.362365069917;12028.999999999989;12039.75920481591;12047.457864396101;12053.939730301357;10928.945355273212;10932.016118549329;10960.671179864597;10986.121110311176;10992.890071099286;607.501848484243;613.089562000429;613.8588124731292;760.8630446519625;761.394691220481;773.6247919758913;774.7985523763833;776.763087258386;778.852018116556;780.9297163255305;806.6087947345533;814.0191069760954;814.7067055859885;815.2255357410454;815.4821688227988;628.7736414890636;636.805774238857;802.2819576479077;817.5299202958263;818.5048045932185;602.6986506746626;603.0321334258496;603.3242768099713;603.5955909540618;604.0817956705827;11391.259568128127;11534.826977595343;11587.420628968517;11601.593944211912;11624.767504649859;10302.484875756258;10866.293690910066;11020.889791102067;11022.834657480063;11183.04944079746;9531.475768832712;9596.136347728669;9619.086186812241;9745.976672449433;9854.753631159207;3192.5211218317204;3231.9030429087165;3253.7397008239286;3254.869805207789;3298.208429976812;39645.20709585792;39779;39803.601963980276;40186.19627607431;40302.39546406806;9222.584983675752;9247.907520924704;9325.720228393158;9353.485558294358;9436.150746432853;16965.915170424316;16979.405720799714;16984.660306793794;17026.914865425595;17029.063401513034;6311.936880631135;6344.080108384258;6398.968005159944;6466.418022378009;6478.902816457757;3235.094173631387;3285.244393789442;3286;3290.6380298167182;3297.1757060734817;2452.4481991551756;2498.5252801967567;2505.035561308909;2505.3360859372283;2506.7367926367833;436.9104333611602;444.46220073711174;449.37761200737214;451.21038183179434;451.9977400112978;446.5289119978389;448.67471083464227;457.38253357966477;494.57466578742253;512.5591990887833;7489.737859174903;7867.9606601966625;8334.958325208336;8567.52878591671;8680.782980425414;589.6579983609582;614.8370681769335;617.6973283091253;621.7730528357117;626.580191271849;3384.6446123157207;3695.3533131701843;3717.8113716620674;3748.306563285801;3769.962300377016;48635.75682121567;48708;48800;48991.51008489869;51206.74396628067;43314.35028474576;43730;44480.77759611181;44514.554854451686;44872.10255794866;40248.396274055915;40303.798481007405;40725.79637101855;40943;40986.79506602448;7067;7189.856202876018;7232.493725439169;7238.420926325986;7268.126906953218;29421.705782941895;29990.25024374408;30285.394292114474;30695;30773.23066923345;35083;35097;35502.28995420129;35907.46138807972;39662;9175.541222938693;9222.769430764285;9373.1564159226;9374.109459601326;9480.857787133336;10160.136388407069;10325.285226815555;10367.43770911135;10369.066783989478;10377.792444151226;9173.174414302744;9209.815803684023;9244.399114057565;9303.209227215491;9446.85829712541;9712.562934668098;9719.27105467107;9808.852867206855;9878.802423951625;9895.307328486937;9299.814003719752;9306.813863722553;9346.579403926975;9400.529973501434;9414.246860251027;8087.63605637736;8358.62386192635;8363.247307742333;8563.058063613122;8756.168164024408;8036.4776289541;8445.028821685339;8943.776405589912;9026.323025773225;9153.725388238363 08:37:53 INFO - PROCESS | 14030 | __end_tp_report 08:37:53 INFO - PROCESS | 14030 | __start_cc_report 08:37:53 INFO - PROCESS | 14030 | _x_x_mozilla_cycle_collect,781 08:37:53 INFO - PROCESS | 14030 | __end_cc_report 08:37:53 INFO - PROCESS | 14030 | __startTimestamp1452184673540__endTimestamp 08:37:53 INFO - PROCESS | 14030 | 08:37:53 INFO - PROCESS | 14030 | ------- Summary: start ------- 08:37:53 INFO - PROCESS | 14030 | Number of tests: 6 08:37:53 INFO - PROCESS | 14030 | 08:37:53 INFO - PROCESS | 14030 | [#0] dojo.html Cycles:165 Average:4506.20 Median:4637.49 stddev:462.18 (10.0%) stddev-sans-first:437.42 08:37:53 INFO - PROCESS | 14030 | Values: 2551.3 2668.3 2671.7 2682.3 2684.5 4365.6 4508.2 4571.3 4623.7 4638.4 4500.2 4527.1 4622.6 4634.4 4634.8 4053.0 4137.2 4186.1 4231.7 4292.9 4239.1 4306.6 4309.7 4312.2 4338.4 4101.3 4140.2 4224.1 4232.6 4245.6 4227.5 4250.8 4259.6 4268.7 4286.1 4226.5 4236.4 4238.3 4245.6 4279.2 4320.5 4448.7 4452.7 4464.8 4600.0 4871.7 4905.7 4910.9 4912.1 4951.8 4927.7 4928.4 4932.7 4933.5 4935.4 4401.4 4487.4 4512.5 4517.6 4520.2 4951.7 4989.4 4992.0 5004.1 5032.3 4797.2 4797.5 4804.0 4804.7 4849.8 4723.6 4865.9 4870.7 4871.9 4883.5 4756.2 4761.3 4807.3 4840.1 4879.1 4834.4 4840.4 4848.4 4848.5 4911.3 3886.2 4027.9 4049.9 4055.0 4088.7 3500.8 3545.5 3584.9 3596.8 3613.4 4214.3 4244.0 4247.4 4252.2 4282.3 4755.6 4872.3 4916.4 4929.8 4974.4 4160.7 4167.4 4185.0 4231.5 4289.0 4299.6 4305.2 4309.7 4314.3 4351.3 4648.3 4651.5 4653.1 4653.9 4685.9 4694.6 4810.6 4810.7 4819.4 4907.3 4690.8 4692.0 4692.4 4711.5 4734.2 4823.9 4826.6 4842.4 4890.9 4892.4 4763.5 4873.6 4878.1 4903.3 4918.0 4637.5 4726.6 4732.1 4735.0 4779.1 4752.1 4753.2 4753.7 4777.2 4796.2 4448.3 4546.5 4554.6 4585.9 4641.4 4766.4 4821.7 4836.2 4839.1 4878.6 4622.1 4625.6 4632.8 4633.1 4673.0 08:37:53 INFO - PROCESS | 14030 | 08:37:53 INFO - PROCESS | 14030 | [#1] ext.html Cycles:180 Average:38909.89 Median:32328.84 stddev:62983.14 (194.8%) stddev-sans-first:63093.72 08:37:53 INFO - PROCESS | 14030 | Values: 480.5 481.3 502.1 505.7 530.6 24530.1 24943.3 32288.0 32523.7 32543.7 35602.0 36009.3 36072.8 36150.3 36156.6 6721.2 6847.3 7563.5 7729.1 7748.9 9579.7 9775.3 9798.5 9801.7 9846.5 9521.9 9629.6 9629.6 9630.7 9641.6 9437.6 9487.0 9523.9 9531.0 9533.7 9376.1 9525.2 9528.9 9529.2 9535.8 34659.0 34996.2 34997.5 35008.0 35055.8 2761.1 2761.5 2781.7 3358.9 3562.3 23765.6 24747.3 27835.9 28059.2 28137.7 3037.8 3049.6 3069.9 3098.1 3128.3 171040.1 175515.0 175936.0 176245.1 176329.0 45316.3 46341.8 49641.0 49948.0 54126.0 48502.3 48509.8 48852.5 48870.3 48994.5 12244.4 12483.4 12493.7 12506.7 12509.0 9315.8 9339.8 9370.6 9381.6 9390.2 17628.5 18500.4 18572.5 18652.4 18659.8 7359.5 7660.5 7705.3 7726.4 7750.6 827.5 871.1 875.7 894.7 981.5 27719.2 28705.0 29293.4 29333.0 29424.7 900.5 941.7 1016.3 1080.8 1098.8 13545.5 13580.0 14093.2 14093.4 14101.8 286580.0 290286.0 291164.0 292052.0 292921.0 45605.5 46123.5 46128.0 46157.0 46224.1 1159.8 1173.6 1196.4 1200.9 1202.5 20837.3 25529.2 26386.3 26691.5 26826.2 38926.8 39395.0 39559.6 39591.8 39649.6 241225.0 244548.0 244718.0 245480.0 245610.0 23735.8 24276.2 28456.3 28986.0 29043.9 32226.2 32369.7 32441.4 40870.2 42166.8 29212.9 29939.4 30010.0 30460.4 30587.8 29337.6 29980.6 30046.4 30177.7 30267.1 30388.0 35091.8 35564.8 35693.1 35733.6 25770.4 29356.1 29692.7 29722.4 29867.4 22991.7 23007.3 23088.5 23290.5 23320.5 08:37:53 INFO - PROCESS | 14030 | 08:37:53 INFO - PROCESS | 14030 | [#2] jquery.html Cycles:180 Average:24585.11 Median:423.04 stddev:74837.89 (17690.3%) stddev-sans-first:75025.63 08:37:53 INFO - PROCESS | 14030 | Values: 311.3 324.0 325.2 326.7 327.8 12389.3 12747.0 15330.2 15721.1 15964.4 12501.1 14817.3 15499.6 16224.1 16266.8 4834.6 4939.7 5045.6 5103.8 5105.4 3512.2 3606.9 4952.8 5121.3 5191.5 5041.1 5067.9 5071.4 5095.5 5096.7 5061.2 5064.3 5221.4 5670.3 5692.1 5045.8 5051.1 5054.7 5055.1 5058.5 10547.6 14681.9 18580.5 18944.0 18998.2 1725.6 1755.3 1777.6 1778.1 1875.3 8320.2 8434.7 8497.2 8550.1 8670.3 1708.7 1756.4 1759.5 1774.0 1783.8 53009.0 55824.7 55978.7 56269.4 57525.4 8980.7 9112.3 9120.0 9173.2 9186.7 11457.5 11491.9 11500.8 11504.8 11510.9 6377.8 6421.3 6459.8 6488.2 6493.1 6176.1 6188.4 6214.5 6238.2 6252.9 3771.8 3831.5 3837.9 3890.9 3966.5 1467.8 1552.5 1586.2 1625.6 1630.8 347.6 350.1 367.5 379.3 769.6 9070.8 9388.3 9647.5 9656.9 9773.6 351.7 355.1 368.6 369.0 374.5 4723.5 5008.8 5049.9 5077.5 5116.2 452887.0 457548.0 457908.0 458571.0 459967.0 66054.3 69935.7 69994.0 70054.6 70316.0 417.5 422.2 423.0 423.1 423.3 8940.6 8950.6 8952.2 9013.3 9203.7 28749.0 29286.7 30499.4 30668.7 32690.3 38736.6 40800.8 41848.0 43074.0 43831.6 7977.9 8076.3 8165.1 8167.1 8198.1 15168.5 15404.2 15426.7 15679.3 16056.3 13098.1 13416.4 13467.3 13806.4 13832.1 12777.2 12831.5 13022.7 13435.1 13435.3 11113.1 13370.7 13914.0 13936.5 14096.3 7080.0 8141.3 8261.1 8365.5 8387.8 9124.8 12622.7 13259.8 13366.7 13828.3 08:37:53 INFO - PROCESS | 14030 | 08:37:53 INFO - PROCESS | 14030 | [#3] mootools.html Cycles:180 Average:4623.50 Median:5685.40 stddev:2386.41 (42.0%) stddev-sans-first:2378.68 08:37:53 INFO - PROCESS | 14030 | Values: 1132.8 1311.9 1327.7 1386.0 1672.4 5746.6 6440.8 6567.9 6574.6 6590.2 6431.5 6608.9 6613.6 6614.4 6615.5 1966.5 1993.3 1994.4 1995.8 1997.2 1961.8 2024.8 2027.8 2031.7 2047.1 1969.3 2007.7 2031.3 2031.5 2033.6 1991.8 2010.9 2015.0 2015.8 2017.9 1953.7 1966.7 1966.9 1985.7 1986.0 6625.6 6626.7 6654.8 6677.8 6696.7 3736.5 3780.9 3794.7 3800.4 3806.3 2614.3 2641.9 2668.3 2688.0 2711.8 889.0 898.5 907.6 912.3 920.1 8831.4 8918.5 8946.0 8959.4 8960.9 3453.7 3460.6 3519.1 3543.8 3556.5 7714.3 7784.6 7801.5 7808.1 7829.1 3854.6 3861.0 3861.4 3863.2 3866.5 3133.9 3204.5 3500.5 3573.9 3581.7 3174.5 3180.8 3211.6 3243.7 3253.2 993.1 1010.2 1014.3 1027.3 1027.7 1125.1 1146.4 1149.4 1155.2 1176.4 6185.5 6290.2 6385.9 6386.7 6397.2 395.0 398.7 400.5 401.2 401.3 5046.8 5109.1 5117.9 5121.1 5122.4 7083.9 7286.1 7851.3 8022.4 8030.9 7811.5 7897.6 7918.2 7928.1 7945.2 6144.2 6266.6 6268.0 6289.2 6299.4 5933.1 5942.9 6053.1 6060.1 6079.8 6862.6 6908.7 7125.6 7127.6 7179.8 7006.8 7301.9 7306.9 7320.6 7389.7 5430.7 5543.0 6142.1 6216.6 6217.7 6127.1 6246.8 6274.0 6279.3 6293.4 5878.3 5907.6 5928.6 6062.9 6199.0 5932.3 6024.8 6043.3 6092.4 6126.4 5726.9 5839.2 5850.9 5855.7 6074.0 5566.6 5589.7 5603.8 5615.5 5643.9 5572.3 5616.6 5636.4 5640.5 5641.4 08:37:53 INFO - PROCESS | 14030 | 08:37:53 INFO - PROCESS | 14030 | [#4] prototype.html Cycles:180 Average:4638.60 Median:5277.60 stddev:1363.04 (25.8%) stddev-sans-first:1327.12 08:37:53 INFO - PROCESS | 14030 | Values: 285.0 288.8 290.9 294.2 295.9 5299.7 5357.4 5367.9 5377.9 5404.1 5048.3 5118.6 5236.2 5274.0 5281.2 4120.7 4123.6 4124.7 4129.3 4132.1 3853.1 4120.2 4121.8 4126.9 4127.3 3876.9 3933.7 4011.4 4021.9 4027.0 4029.8 4071.2 4072.3 4074.6 4092.0 3599.8 3604.2 3605.0 3614.9 3617.5 5107.5 5116.2 5129.1 5131.7 5140.5 4619.0 4714.8 4719.1 4721.1 4731.6 5550.9 5554.9 5559.3 5561.4 5564.3 3934.4 3936.7 3937.3 3938.9 3944.4 5833.0 5833.3 5844.1 5845.5 5846.9 3970.7 4055.4 4063.2 4065.9 4090.9 4089.1 4098.6 4128.6 4134.0 4134.5 4637.8 4638.0 4643.3 4680.7 4696.3 5536.8 5557.9 5586.5 5587.9 5588.2 1419.8 1424.9 1447.6 1455.7 1463.2 969.5 987.3 998.9 1007.5 1008.9 4888.9 4896.4 4899.8 4906.4 4914.8 5783.5 5788.7 5796.0 5808.9 5809.9 4698.7 4791.2 4800.9 4894.0 4944.6 3111.2 3135.9 3139.1 3153.9 3156.0 5491.8 5509.8 5523.6 5525.7 5533.4 5961.1 5977.5 5979.3 5980.0 5986.6 5368.5 5524.2 5540.0 5551.4 5556.5 5772.1 5846.6 5858.9 5863.1 5871.6 5705.1 5721.3 5722.7 5723.3 5724.4 5352.0 5511.6 5541.8 5550.9 5553.1 3985.0 4028.1 4030.2 4031.0 4034.9 5792.1 5795.8 5796.9 5802.3 5805.1 5556.3 5597.7 5599.1 5599.7 5602.0 5424.5 5550.1 5601.1 5640.2 5647.5 5439.9 5467.5 5474.2 5475.8 5481.5 5669.4 5670.5 5675.1 5683.1 5694.7 5353.3 5411.5 5470.4 5487.2 5493.1 08:37:53 INFO - PROCESS | 14030 | 08:37:53 INFO - PROCESS | 14030 | [#5] yui.html Cycles:180 Average:11873.99 Median:596.18 stddev:13560.64 (2274.6%) stddev-sans-first:13573.05 08:37:53 INFO - PROCESS | 14030 | Values: 770.5 784.5 789.6 799.4 800.0 11593.4 12029.0 12039.8 12047.5 12053.9 10928.9 10932.0 10960.7 10986.1 10992.9 607.5 613.1 613.9 760.9 761.4 773.6 774.8 776.8 778.9 780.9 806.6 814.0 814.7 815.2 815.5 628.8 636.8 802.3 817.5 818.5 602.7 603.0 603.3 603.6 604.1 11391.3 11534.8 11587.4 11601.6 11624.8 10302.5 10866.3 11020.9 11022.8 11183.0 9531.5 9596.1 9619.1 9746.0 9854.8 3192.5 3231.9 3253.7 3254.9 3298.2 39645.2 39779.0 39803.6 40186.2 40302.4 9222.6 9247.9 9325.7 9353.5 9436.2 16965.9 16979.4 16984.7 17026.9 17029.1 6311.9 6344.1 6399.0 6466.4 6478.9 3235.1 3285.2 3286.0 3290.6 3297.2 2452.4 2498.5 2505.0 2505.3 2506.7 436.9 444.5 449.4 451.2 452.0 446.5 448.7 457.4 494.6 512.6 7489.7 7868.0 8335.0 8567.5 8680.8 589.7 614.8 617.7 621.8 626.6 3384.6 3695.4 3717.8 3748.3 3770.0 48635.8 48708.0 48800.0 48991.5 51206.7 43314.4 43730.0 44480.8 44514.6 44872.1 40248.4 40303.8 40725.8 40943.0 40986.8 7067.0 7189.9 7232.5 7238.4 7268.1 29421.7 29990.3 30285.4 30695.0 30773.2 35083.0 35097.0 35502.3 35907.5 39662.0 9175.5 9222.8 9373.2 9374.1 9480.9 10160.1 10325.3 10367.4 10369.1 10377.8 9173.2 9209.8 9244.4 9303.2 9446.9 9712.6 9719.3 9808.9 9878.8 9895.3 9299.8 9306.8 9346.6 9400.5 9414.2 8087.6 8358.6 8363.2 8563.1 8756.2 8036.5 8445.0 8943.8 9026.3 9153.7 08:37:53 INFO - PROCESS | 14030 | -------- Summary: end -------- 08:37:53 INFO - PROCESS | 14030 | 08:37:54 INFO - TEST-INFO | 14030: exit 0 08:37:54 INFO - TEST-OK | dromaeo_css | took 1117311ms 08:37:54 INFO - TEST-START | kraken 08:37:54 INFO - operating with platform_type : linux_ 08:37:54 INFO - Initialising browser for kraken test... 08:37:54 INFO - TEST-INFO | started process 14225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0EaSsy/profile http://localhost:46602/getInfo.html) 08:37:59 INFO - PROCESS | 14225 | __metrics Screen width/height:1600/1200 08:37:59 INFO - PROCESS | 14225 | colorDepth:24 08:37:59 INFO - PROCESS | 14225 | Browser inner width/height: 1024/697 08:37:59 INFO - PROCESS | 14225 | __metrics 08:37:59 INFO - PROCESS | 14225 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:37:59 INFO - PROCESS | 14225 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:38:00 INFO - TEST-INFO | 14225: exit 0 08:38:00 INFO - Browser initialized. 08:38:00 INFO - Running cycle 1/1 for kraken test... 08:38:00 INFO - TEST-INFO | started process 14310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0EaSsy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:12 INFO - PROCESS | 14310 | RSS: Main: 150011904 08:38:12 INFO - PROCESS | 14310 | 08:38:15 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46602/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:15 INFO - PROCESS | 14310 | RSS: Main: 184655872 08:38:15 INFO - PROCESS | 14310 | 08:38:18 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46602/tests/kraken/driver.html?testName=audio-dft) 08:38:19 INFO - PROCESS | 14310 | RSS: Main: 175837184 08:38:19 INFO - PROCESS | 14310 | 08:38:22 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46602/tests/kraken/driver.html?testName=audio-fft) 08:38:22 INFO - PROCESS | 14310 | RSS: Main: 161423360 08:38:22 INFO - PROCESS | 14310 | 08:38:24 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46602/tests/kraken/driver.html?testName=audio-oscillator) 08:38:25 INFO - PROCESS | 14310 | RSS: Main: 163893248 08:38:25 INFO - PROCESS | 14310 | 08:38:27 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46602/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:28 INFO - PROCESS | 14310 | RSS: Main: 166617088 08:38:28 INFO - PROCESS | 14310 | 08:38:31 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46602/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:31 INFO - PROCESS | 14310 | RSS: Main: 166322176 08:38:31 INFO - PROCESS | 14310 | 08:38:35 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46602/tests/kraken/driver.html?testName=imaging-desaturate) 08:38:35 INFO - PROCESS | 14310 | RSS: Main: 167301120 08:38:35 INFO - PROCESS | 14310 | 08:38:38 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46602/tests/kraken/driver.html?testName=json-parse-financial) 08:38:39 INFO - PROCESS | 14310 | RSS: Main: 166195200 08:38:39 INFO - PROCESS | 14310 | 08:38:40 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46602/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:38:41 INFO - PROCESS | 14310 | RSS: Main: 175898624 08:38:41 INFO - PROCESS | 14310 | 08:38:43 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:38:43 INFO - PROCESS | 14310 | RSS: Main: 174858240 08:38:43 INFO - PROCESS | 14310 | 08:38:46 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:38:46 INFO - PROCESS | 14310 | RSS: Main: 187650048 08:38:46 INFO - PROCESS | 14310 | 08:38:49 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:38:49 INFO - PROCESS | 14310 | RSS: Main: 190672896 08:38:49 INFO - PROCESS | 14310 | 08:38:52 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:38:52 INFO - PROCESS | 14310 | RSS: Main: 188137472 08:38:52 INFO - PROCESS | 14310 | 08:38:54 INFO - PROCESS | 14310 | Cycle 1(1): loaded http://localhost:46602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46602/tests/kraken/driver.html?testName=ai-astar) 08:38:55 INFO - PROCESS | 14310 | RSS: Main: 246075392 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | __start_tp_report 08:38:55 INFO - PROCESS | 14310 | _x_x_mozilla_page_load 08:38:55 INFO - PROCESS | 14310 | _x_x_mozilla_page_load_details 08:38:55 INFO - PROCESS | 14310 | |i|pagename|runs| 08:38:55 INFO - PROCESS | 14310 | |0;ai-astar;111;114;109;113;113;113;102;113;113;106 08:38:55 INFO - PROCESS | 14310 | |1;audio-beat-detection;161;130;155;192;132;156;164;136;167;128 08:38:55 INFO - PROCESS | 14310 | |2;audio-dft;161;161;161;161;164;161;163;162;162;161 08:38:55 INFO - PROCESS | 14310 | |3;audio-fft;75;75;85;90;76;72;73;99;89;72 08:38:55 INFO - PROCESS | 14310 | |4;audio-oscillator;99;98;137;97;98;98;133;102;98;141 08:38:55 INFO - PROCESS | 14310 | |5;imaging-gaussian-blur;110;109;109;109;108;109;109;109;110;109 08:38:55 INFO - PROCESS | 14310 | |6;imaging-darkroom;147;146;147;147;146;146;147;146;146;147 08:38:55 INFO - PROCESS | 14310 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;96;95 08:38:55 INFO - PROCESS | 14310 | |8;json-parse-financial;71;71;72;71;72;72;72;81;68;70 08:38:55 INFO - PROCESS | 14310 | |9;json-stringify-tinderbox;68;68;68;68;68;69;68;68;67;69 08:38:55 INFO - PROCESS | 14310 | |10;stanford-crypto-aes;85;85;84;86;85;83;85;97;87;90 08:38:55 INFO - PROCESS | 14310 | |11;stanford-crypto-ccm;125;138;122;118;120;121;127;129;121;128 08:38:55 INFO - PROCESS | 14310 | |12;stanford-crypto-pbkdf2;135;149;147;146;148;136;146;146;147;135 08:38:55 INFO - PROCESS | 14310 | |13;stanford-crypto-sha256-iterative;71;71;73;73;71;69;71;70;70;70 08:38:55 INFO - PROCESS | 14310 | __end_tp_report 08:38:55 INFO - PROCESS | 14310 | __start_cc_report 08:38:55 INFO - PROCESS | 14310 | _x_x_mozilla_cycle_collect,978 08:38:55 INFO - PROCESS | 14310 | __end_cc_report 08:38:55 INFO - PROCESS | 14310 | __startTimestamp1452184735032__endTimestamp 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | ------- Summary: start ------- 08:38:55 INFO - PROCESS | 14310 | Number of tests: 14 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#0] ai-astar Cycles:10 Average:110.70 Median:113.00 stddev:3.92 (3.5%) stddev-sans-first:4.15 08:38:55 INFO - PROCESS | 14310 | Values: 111.0 114.0 109.0 113.0 113.0 113.0 102.0 113.0 113.0 106.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:158.50 stddev:20.52 (12.9%) stddev-sans-first:21.51 08:38:55 INFO - PROCESS | 14310 | Values: 161.0 130.0 155.0 192.0 132.0 156.0 164.0 136.0 167.0 128.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 08:38:55 INFO - PROCESS | 14310 | Values: 161.0 161.0 161.0 161.0 164.0 161.0 163.0 162.0 162.0 161.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#3] audio-fft Cycles:10 Average:80.60 Median:80.50 stddev:9.47 (11.8%) stddev-sans-first:9.82 08:38:55 INFO - PROCESS | 14310 | Values: 75.0 75.0 85.0 90.0 76.0 72.0 73.0 99.0 89.0 72.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:98.00 stddev:18.71 (19.1%) stddev-sans-first:19.40 08:38:55 INFO - PROCESS | 14310 | Values: 99.0 98.0 137.0 97.0 98.0 98.0 133.0 102.0 98.0 141.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 08:38:55 INFO - PROCESS | 14310 | Values: 110.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 110.0 109.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:38:55 INFO - PROCESS | 14310 | Values: 147.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 147.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:38:55 INFO - PROCESS | 14310 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#8] json-parse-financial Cycles:10 Average:72.00 Median:72.00 stddev:3.40 (4.7%) stddev-sans-first:3.59 08:38:55 INFO - PROCESS | 14310 | Values: 71.0 71.0 72.0 71.0 72.0 72.0 72.0 81.0 68.0 70.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 08:38:55 INFO - PROCESS | 14310 | Values: 68.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 67.0 69.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.50 stddev:4.08 (4.8%) stddev-sans-first:4.28 08:38:55 INFO - PROCESS | 14310 | Values: 85.0 85.0 84.0 86.0 85.0 83.0 85.0 97.0 87.0 90.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.00 stddev:5.90 (4.7%) stddev-sans-first:6.25 08:38:55 INFO - PROCESS | 14310 | Values: 125.0 138.0 122.0 118.0 120.0 121.0 127.0 129.0 121.0 128.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:146.50 stddev:5.72 (3.9%) stddev-sans-first:5.17 08:38:55 INFO - PROCESS | 14310 | Values: 135.0 149.0 147.0 146.0 148.0 136.0 146.0 146.0 147.0 135.0 08:38:55 INFO - PROCESS | 14310 | 08:38:55 INFO - PROCESS | 14310 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:1.29 (1.8%) stddev-sans-first:1.36 08:38:55 INFO - PROCESS | 14310 | Values: 71.0 71.0 73.0 73.0 71.0 69.0 71.0 70.0 70.0 70.0 08:38:55 INFO - PROCESS | 14310 | -------- Summary: end -------- 08:38:55 INFO - PROCESS | 14310 | 08:38:56 INFO - TEST-INFO | 14310: exit 0 08:38:56 INFO - TEST-OK | kraken | took 61728ms 08:38:56 INFO - TEST-START | v8_7 08:38:56 INFO - operating with platform_type : linux_ 08:38:56 INFO - Initialising browser for v8_7 test... 08:38:56 INFO - TEST-INFO | started process 14555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Wwfnk/profile http://localhost:46602/getInfo.html) 08:39:00 INFO - PROCESS | 14555 | __metrics Screen width/height:1600/1200 08:39:00 INFO - PROCESS | 14555 | colorDepth:24 08:39:00 INFO - PROCESS | 14555 | Browser inner width/height: 1024/697 08:39:00 INFO - PROCESS | 14555 | __metrics 08:39:01 INFO - PROCESS | 14555 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:39:01 INFO - PROCESS | 14555 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:39:02 INFO - TEST-INFO | 14555: exit 0 08:39:02 INFO - Browser initialized. 08:39:02 INFO - Running cycle 1/1 for v8_7 test... 08:39:02 INFO - TEST-INFO | started process 14638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Wwfnk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:14 INFO - PROCESS | 14638 | RSS: Main: 149655552 08:39:14 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | Cycle 1(1): loaded http://localhost:46602/tests/v8_7/run.html (next: http://localhost:46602/tests/v8_7/run.html) 08:39:35 INFO - PROCESS | 14638 | RSS: Main: 445009920 08:39:35 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | __start_tp_report 08:39:35 INFO - PROCESS | 14638 | _x_x_mozilla_page_load 08:39:35 INFO - PROCESS | 14638 | _x_x_mozilla_page_load_details 08:39:35 INFO - PROCESS | 14638 | |i|pagename|runs| 08:39:35 INFO - PROCESS | 14638 | |0;Richards;166.16816218012627 08:39:35 INFO - PROCESS | 14638 | |1;DeltaBlue;188.00526414739613 08:39:35 INFO - PROCESS | 14638 | |2;Encrypt;279.17364600781684 08:39:35 INFO - PROCESS | 14638 | |3;Decrypt;5240.837696335078 08:39:35 INFO - PROCESS | 14638 | |4;RayTrace;2018.1451612903227 08:39:35 INFO - PROCESS | 14638 | |5;Earley;831.9467554076539 08:39:35 INFO - PROCESS | 14638 | |6;Boyer;12268.292682926829 08:39:35 INFO - PROCESS | 14638 | |7;RegExp;26710.526315789473 08:39:35 INFO - PROCESS | 14638 | |8;Splay;615.7635467980296 08:39:35 INFO - PROCESS | 14638 | |9;NavierStokes;4835.748792270531 08:39:35 INFO - PROCESS | 14638 | __end_tp_report 08:39:35 INFO - PROCESS | 14638 | __startTimestamp1452184775772__endTimestamp 08:39:35 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | ------- Summary: start ------- 08:39:35 INFO - PROCESS | 14638 | Number of tests: 10 08:39:35 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 08:39:35 INFO - PROCESS | 14638 | Values: 166.2 08:39:35 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | [#1] DeltaBlue Cycles:1 Average:188.01 Median:188.01 stddev:0.00 (0.0%) 08:39:35 INFO - PROCESS | 14638 | Values: 188.0 08:39:35 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 08:39:35 INFO - PROCESS | 14638 | Values: 279.2 08:39:35 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 08:39:35 INFO - PROCESS | 14638 | Values: 5240.8 08:39:35 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | [#4] RayTrace Cycles:1 Average:2018.15 Median:2018.15 stddev:0.00 (0.0%) 08:39:35 INFO - PROCESS | 14638 | Values: 2018.1 08:39:35 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | [#5] Earley Cycles:1 Average:831.95 Median:831.95 stddev:0.00 (0.0%) 08:39:35 INFO - PROCESS | 14638 | Values: 831.9 08:39:35 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 08:39:35 INFO - PROCESS | 14638 | Values: 12268.3 08:39:35 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | [#7] RegExp Cycles:1 Average:26710.53 Median:26710.53 stddev:0.00 (0.0%) 08:39:35 INFO - PROCESS | 14638 | Values: 26710.5 08:39:35 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | [#8] Splay Cycles:1 Average:615.76 Median:615.76 stddev:0.00 (0.0%) 08:39:35 INFO - PROCESS | 14638 | Values: 615.8 08:39:35 INFO - PROCESS | 14638 | 08:39:35 INFO - PROCESS | 14638 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 08:39:35 INFO - PROCESS | 14638 | Values: 4835.7 08:39:35 INFO - PROCESS | 14638 | -------- Summary: end -------- 08:39:35 INFO - PROCESS | 14638 | 08:39:36 INFO - TEST-INFO | 14638: exit 0 08:39:36 INFO - TEST-OK | v8_7 | took 40660ms 08:39:36 INFO - SUITE-END | took 1219s 08:39:36 INFO - Completed test suite (00:20:19) 08:39:36 INFO - Working with test: dromaeo_css 08:39:36 INFO - Generating results file: dromaeo_css 08:39:36 INFO - Working with test: kraken 08:39:36 INFO - Generating results file: kraken 08:39:36 INFO - javascript benchmark 08:39:36 INFO - Working with test: v8_7 08:39:36 INFO - Generating results file: v8_7 08:39:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:39:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 08:39:36 INFO - process_Request line: dromaeo_css 5969.34 graph.html#tests=[[72,203,35]] 08:39:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:39:36 INFO - process_Request line: kraken 1532.10 graph.html#tests=[[232,203,35]] 08:39:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:39:36 INFO - process_Request line: v8_7 19587.90 graph.html#tests=[[230,203,35]] 08:39:36 INFO - RETURN: dromaeo_css: 5969.34 08:39:36 INFO - RETURN: kraken: 1532.10 08:39:36 INFO - RETURN: v8_7: 19587.90 08:39:36 INFO - javascript benchmark 08:39:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2551.3111459905826, 2668.3329167708075, 2671.666041744782, 2682.342826007628, 2684.5167869783445, 4365.563443655633, 4508.165989291975, 4571.2914498252785, 4623.722576645404, 4638.420197475316, 4500.1674690182335, 4527.09458108378, 4622.630189584834, 4634.3511908332775, 4634.791434385453, 4052.9797351013203, 4137.180185084383, 4186.099988502471, 4231.70378073535, 4292.860300728722, 4239.08859595187, 4306.61240488356, 4309.719868208572, 4312.22379971605, 4338.414314067592, 4101.323281658538, 4140.23405669952, 4224.112936283384, 4232.640225580829, 4245.596668316505, 4227.534971153171, 4250.808713607895, 4259.61663450291, 4268.679849011305, 4286.099919016979, 4226.535081141072, 4236.428082208893, 4238.258304796679, 4245.596668316505, 4279.229738647043, 4320.481542214954, 4448.7108337957925, 4452.710573812724, 4464.776761161929, 4600.033992861503, 4871.658983871131, 4905.705657660552, 4910.90178196434, 4912.115819152551, 4951.8266860659705, 4927.6550641455115, 4928.408590969071, 4932.679375840559, 4933.45731969483, 4935.432425271104, 4401.361802538646, 4487.439070116236, 4512.481064677604, 4517.593416592523, 4520.2315606347, 4951.678140920901, 4989.351384320015, 4991.975040124777, 5004.074246264453, 5032.32063671407, 4797.18447863864, 4797.496262892416, 4804.015176888729, 4804.711717296974, 4849.80600775965, 4723.574878260904, 4865.854024379274, 4870.659053866196, 4871.902561948741, 4883.51164883516, 4756.167670657621, 4761.285807128958, 4807.254875494304, 4840.056189043174, 4879.121758083579, 4834.371531700926, 4840.394950631171, 4848.418189817174, 4848.490908454632, 4911.263310503382, 3886.1839013807416, 4027.8791636250958, 4049.919001619951, 4055.026793569581, 4088.693347998912, 3500.754947153675, 3545.503629491873, 3584.928301434009, 3596.7841929484316, 3613.4218525035867, 4214.346776249687, 4244.02387450888, 4247.405363249148, 4252.213340532012, 4282.314829627245, 4755.619550435957, 4872.293517439952, 4916.385451818523, 4929.841487250494, 4974.37820272466, 4160.729552579072, 4167.395727619478, 4184.958150418457, 4231.492220933507, 4289.03496713237, 4299.613034826881, 4305.182015417061, 4309.698321117555, 4314.288142456522, 4351.303791393425, 4648.25627899548, 4651.488336283074, 4653.092646933883, 4653.860384188412, 4685.882852928636, 4694.577488026094, 4810.5670489656095, 4810.7113573185725, 4819.445763737075, 4907.288443175791, 4690.788914498788, 4691.953080469151, 4692.389989301369, 4711.528847115261, 4734.242521196592, 4823.927641085316, 4826.58973987215, 4842.394700662418, 4890.850650097295, 4892.3884514435695, 4763.499832517536, 4873.634477414137, 4878.121938051185, 4903.31353610502, 4918.040982008474, 4637.489876113557, 4726.6455015874635, 4732.100900828831, 4735.0, 4779.139754844162, 4752.120857641347, 4753.191957367187, 4753.667243292936, 4777.235642297216, 4796.232602783538, 4448.288273876165, 4546.477155127071, 4554.635629149594, 4585.931211031904, 4641.373414589122, 4766.356541866804, 4821.686590371614, 4836.226203807374, 4839.056384005085, 4878.609711223165, 4622.075584882969, 4625.629949604091, 4632.8146874126005, 4633.05022470386, 4672.976635116803], "unit": "score", "name": "dojo.html", "value": 4478.023257631089}, {"lowerIsBetter": false, "replicates": [480.50027970910253, 481.2516536785302, 502.07868561190213, 505.6637336171446, 530.5940955169297, 24530.141445049427, 24943.25170244893, 32288.0, 32523.67476325242, 32543.67456325436, 35602.0, 36009.27981440369, 36072.81963590178, 36150.276994460095, 36156.638433615655, 6721.193456785192, 6847.281035491276, 7563.508371955832, 7729.072511298624, 7748.883766743504, 9579.712608621718, 9775.31572789905, 9798.510074496282, 9801.705948821547, 9846.458444785534, 9521.857172142423, 9629.614815407374, 9629.614815407374, 9630.711078667651, 9641.61433542661, 9437.622495100188, 9487.0, 9523.904760952371, 9531.046895310448, 9533.713988580354, 9376.109269619375, 9525.237831001286, 9528.857067143997, 9529.237660987104, 9535.761605959837, 34659.0, 34996.200303975624, 34997.47503787445, 35008.0, 35055.82472087623, 2761.144045345949, 2761.4615150045747, 2781.694013658496, 3358.9496157557655, 3562.3029451758207, 23765.643515347285, 24747.25758227256, 27835.86082069597, 28059.15822525307, 28137.718622813714, 3037.817730936151, 3049.618797650294, 3069.8772049118234, 3098.086064610945, 3128.311771410286, 171040.14479927646, 175515.0, 175936.0, 176245.11877440658, 176329.0, 45316.320255196195, 46341.768291159, 49641.0, 49948.0, 54126.0, 48502.27246591304, 48509.75745121252, 48852.511474885505, 48870.26694599584, 48994.51005489971, 12244.387780610934, 12483.438245278985, 12493.687657808627, 12506.749865002648, 12509.0, 9315.813683726288, 9339.813203735886, 9370.625174992923, 9381.577828997712, 9390.201832844148, 17628.471145865646, 18500.35248766287, 18572.535686607942, 18652.44042678722, 18659.81340186581, 7359.521631093961, 7660.502067365604, 7705.30652241301, 7726.38188944883, 7750.605750256062, 827.4538804389074, 871.0679572856982, 875.7285241575132, 894.6742500012383, 981.499435287994, 27719.168424947286, 28705.0, 29293.414131717247, 29332.97334593279, 29424.705752942198, 900.4642237868458, 941.7316064921464, 1016.3139880580578, 1080.7892460970036, 1098.780243951213, 13545.525906593222, 13580.0, 14093.2248726319, 14093.365798539091, 14101.78847317291, 286580.0, 290286.0, 291164.0, 292052.0, 292921.0, 45605.54394456079, 46123.53876461193, 46128.0, 46157.0, 46224.07551849011, 1159.7970355187808, 1173.5657806611437, 1196.4017991004498, 1200.8919197272112, 1202.5310129049678, 20837.270695525585, 25529.23412297634, 26386.34034149085, 26691.466170676867, 26826.19521414361, 38926.80536597299, 39395.0, 39559.60440395674, 39591.80204098961, 39649.603503964594, 241225.0, 244548.0, 244718.0, 245480.0, 245610.0, 23735.762642373356, 24276.1503347382, 28456.288592785346, 28986.0, 29043.85478072596, 32226.194345140622, 32369.676303236665, 32441.35117297688, 40870.1825963485, 42166.789166053975, 29212.853935730185, 29939.401211976074, 30010.0, 30460.39079218359, 30587.847060764554, 29337.55993660054, 29980.550291745207, 30046.399072018, 30177.698223017487, 30267.09198724042, 30388.0, 35091.82454087713, 35564.822175888956, 35693.1076723084, 35733.64266357303, 25770.35574110662, 29356.119316420543, 29692.703072968994, 29722.405551889275, 29867.402651947275, 22991.65512517347, 23007.309780706604, 23088.53822923566, 23290.53418931646, 23320.533589328457], "unit": "score", "name": "ext.html", "value": 16404.26648391975}, {"lowerIsBetter": false, "replicates": [311.30734116590577, 324.005303717587, 325.1740578929519, 326.7320796946505, 327.7738360531233, 12389.256644601308, 12747.043971702136, 15330.23348832558, 15721.13533755643, 15964.441244556443, 12501.124921255516, 14817.259137043158, 15499.612509687235, 16224.10767407792, 16266.83733162668, 4834.564889159966, 4939.703617782927, 5045.646804723652, 5103.770330335125, 5105.4128775190775, 3512.1921957949558, 3606.945895811565, 4952.752362381884, 5121.257417674435, 5191.506806853343, 5041.067402530525, 5067.898642027158, 5071.442141364447, 5095.464976177485, 5096.719680417576, 5061.19020956647, 5064.3163172971545, 5221.39953905302, 5670.3479099903625, 5692.0608099663505, 5045.798168073273, 5051.06555287273, 5054.721990290533, 5055.11535481293, 5058.494150584949, 10547.578096876192, 14681.926590367086, 18580.535486612807, 18944.0, 18998.24007039717, 1725.6376161006203, 1755.3242001829387, 1777.6089260362698, 1778.1020584604692, 1875.268645228362, 8320.167983201693, 8434.662613495453, 8497.235248827574, 8550.10223926485, 8670.263027642657, 1708.709519381708, 1756.3852651571976, 1759.472158352502, 1773.9976913044088, 1783.7502749615064, 53009.0, 55824.72087639577, 55978.72010639962, 56269.43730562724, 57525.424745752425, 8980.697798819134, 9112.271018318519, 9119.954400227956, 9173.174414302612, 9186.724398267928, 11457.484413201259, 11491.942540287246, 11500.827487587692, 11504.827427588592, 11510.942445287887, 6377.840553986095, 6421.2615549211505, 6459.773907913201, 6488.156539649815, 6493.123428337114, 6176.135341052256, 6188.381161883775, 6214.533909956771, 6238.189035425366, 6252.874942501125, 3771.7548359356556, 3831.5210598675167, 3837.865674701372, 3890.8832735017995, 3966.504186976628, 1467.7504824179914, 1552.534239728077, 1586.1593355521593, 1625.617979774752, 1630.7524743571178, 347.598523705121, 350.14913759563996, 367.5497515543438, 379.2528718424699, 769.6075001749036, 9070.81858362829, 9388.342816002814, 9647.517624118766, 9656.855147172657, 9773.609055637837, 351.72038229607523, 355.0666620252699, 368.5761374419439, 369.0349735441854, 374.5206136145738, 4723.527647235249, 5008.84973450797, 5049.8737531562, 5077.492250774893, 5116.181410974301, 452887.0, 457548.0, 457908.0, 458571.0, 459967.0, 66054.33945660578, 69935.65032174806, 69994.0, 70054.64972675104, 70316.0, 417.53444908926326, 422.2210022508467, 422.97462152270964, 423.1135770560671, 423.25084600257986, 8940.642374304955, 8950.641974320954, 8952.194302512544, 9013.324000699842, 9203.677871274473, 28749.0, 29286.707132928397, 30499.390012200074, 30668.693313066582, 32690.346193076482, 38736.61263387443, 40800.79599601983, 41848.0, 43074.0, 43831.561684382745, 7977.880331795144, 8076.313513351431, 8165.061017983008, 8167.0607880092175, 8198.098209196864, 15168.544943651708, 15404.229788510755, 15426.691466170838, 15679.29443175037, 16056.277467514223, 13098.083134180515, 13416.396262168031, 13467.259300738162, 13806.447742090606, 13832.100913440594, 12777.16948398351, 12831.486740530274, 13022.674433139247, 13435.059545831698, 13435.328233588478, 11113.110951124052, 13370.732585348043, 13914.0, 13936.512222072179, 14096.295185240491, 7080.0, 8141.348692104736, 8261.09127995932, 8365.498070115813, 8387.790305242417, 9124.771880703036, 12622.747545049231, 13259.80110298327, 13366.665833354244, 13828.30858457053], "unit": "score", "name": "jquery.html", "value": 7110.532688967278}, {"lowerIsBetter": false, "replicates": [1132.8130858408363, 1311.855116883895, 1327.6680829792551, 1385.972280554389, 1672.4230140601487, 5746.569007324451, 6440.806775796727, 6567.901481477782, 6574.605523668572, 6590.242122155947, 6431.485481161508, 6608.933910660904, 6613.636250006248, 6614.3716346947085, 6615.503837212204, 1966.459223713476, 1993.252530301137, 1994.3917105282883, 1995.7704863940687, 1997.2410484016054, 1961.8234358907696, 2024.787397323282, 2027.8276346510565, 2031.7155598216261, 2047.119738512439, 1969.2812123574936, 2007.6687346587796, 2031.3195079648262, 2031.4819720971132, 2033.6136134134467, 1991.790861959495, 2010.9195632174697, 2014.969775453362, 2015.7883422240673, 2017.8890161041136, 1953.736245606839, 1966.7246585478044, 1966.9213231470724, 1985.7319261899604, 1985.9702104468445, 6625.5693379930635, 6626.7017984190825, 6654.800355989328, 6677.766278180289, 6696.732130714766, 3736.5142531470733, 3780.8676696315497, 3794.677452416548, 3800.391937290048, 3806.3148633246005, 2614.3202767280454, 2641.9207423777316, 2668.3329167708075, 2687.9731202688113, 2711.7830573554265, 888.9911100888972, 898.5148020069155, 907.5961197267219, 912.2519533982137, 920.1166879795404, 8831.425957312755, 8918.464892106495, 8946.0, 8959.41763785352, 8960.8655870162, 3453.6546345365264, 3460.567429071366, 3519.1378112362636, 3543.805090720035, 3556.4665300205174, 7714.3442807362, 7784.649690763929, 7801.45389822707, 7808.141104478503, 7829.099653539802, 3854.5567259764925, 3861.0, 3861.4400911868183, 3863.16941857502, 3866.5360156781367, 3133.89031383905, 3204.471262241704, 3500.544929159193, 3573.874914377984, 3581.7492775505984, 3174.492081266986, 3180.840957952093, 3211.550382946343, 3243.675632436785, 3253.2354896599754, 993.101243374747, 1010.1767059846202, 1014.2697257974247, 1027.337367398039, 1027.6557353286732, 1125.094299089241, 1146.4382452598168, 1149.436775979764, 1155.179822326141, 1176.3765204441659, 6185.505159587222, 6290.150829638032, 6385.904211436832, 6386.712597933104, 6397.232332120082, 394.9822257998397, 398.7288643722239, 400.4553806822719, 401.17358242021527, 401.33979603552575, 5046.798128074909, 5109.054824857413, 5117.948820511821, 5121.078205922895, 5122.385313762298, 7083.858322833617, 7286.089238845145, 7851.29338359539, 8022.358211343078, 8030.879536806952, 7811.4922530035365, 7897.565633890191, 7918.168592297726, 7928.088269848926, 7945.205479452008, 6144.201253837062, 6266.561340706106, 6268.028455589391, 6289.24529056507, 6299.370062993664, 5933.080372542263, 5942.881142377042, 6053.122297266959, 6060.090986352083, 6079.848003799941, 6862.588244705334, 6908.689108990208, 7125.572465652078, 7127.643617819192, 7179.784606461814, 7006.75476358325, 7301.890471642823, 7306.926930730625, 7320.597367144858, 7389.741359052622, 5430.70131142791, 5542.972285138549, 6142.078688196806, 6216.595921265103, 6217.658028808459, 6127.050307202391, 6246.843828904313, 6274.0, 6279.335975966281, 6293.370662933853, 5878.29460464747, 5907.645541267538, 5928.584999050025, 6062.878742425215, 6199.0, 5932.2584676915385, 6024.849378765566, 6043.3050199227655, 6092.390760923872, 6126.387361264016, 5726.856828579319, 5839.240898683144, 5850.882982340415, 5855.736491857791, 6074.0281554951, 5566.638168519034, 5589.664620122806, 5603.775848966159, 5615.522680572197, 5643.943560564342, 5572.331320241597, 5616.634918730269, 5636.351819540805, 5640.492355688008, 5641.40765219646], "unit": "score", "name": "mootools.html", "value": 3758.006461556207}, {"lowerIsBetter": false, "replicates": [284.9886004559818, 288.8180446318819, 290.86620154728837, 294.15577293168604, 295.91418488638294, 5299.708516031616, 5357.357117145938, 5367.892642147155, 5377.892442151155, 5404.108322126849, 5048.3437153170125, 5118.564921981636, 5236.188390799422, 5274.0, 5281.207818827178, 4120.711550191488, 4123.60825721556, 4124.711270211086, 4129.29801933672, 4132.111596006858, 3853.0945227871566, 4120.217158739845, 4121.793910304487, 4126.938095928564, 4127.2570937231285, 3876.8643097491595, 3933.704972127088, 4011.3581826907703, 4021.939670904939, 4026.9529922220286, 4029.758214507124, 4071.2061148076136, 4072.287349713818, 4074.5925407459313, 4091.9795401022952, 3599.766015209003, 3604.1530240393486, 3604.981975090134, 3614.8554057837655, 3617.457381392786, 5107.463716309809, 5116.155834287338, 5129.1024070787835, 5131.743412829381, 5140.511651393112, 4618.976905115453, 4714.787834547454, 4719.056188762227, 4721.102990431807, 4731.550502702238, 5550.888982220333, 5554.888902221974, 5559.277293951801, 5561.443855614447, 5564.304461942257, 3934.429507721364, 3936.744111632763, 3937.2912875682364, 3938.921221575581, 3944.408338749182, 5832.999999999957, 5833.32916714579, 5844.064949608042, 5845.532357411397, 5846.883062338729, 3970.662493688011, 4055.3511438169753, 4063.227986682521, 4065.8780236592947, 4090.8568200112854, 4089.0595163112653, 4098.631123198927, 4128.649064829463, 4134.049168691157, 4134.4831896013, 4637.837675681335, 4637.95362046382, 4643.349931009661, 4680.742559159211, 4696.272077827942, 5536.778528858881, 5557.888422315553, 5586.525145362609, 5587.888242235133, 5588.2455868458055, 1419.8296204455532, 1424.893133015028, 1447.623617859343, 1455.7088582283586, 1463.2025546077414, 969.486172328667, 987.2940847294219, 998.9150922171551, 1007.4610083605236, 1008.9445080520642, 4888.877778055577, 4896.387951506062, 4899.804007839646, 4906.435759887659, 4914.778834952435, 5783.537317014629, 5788.710564471759, 5796.0, 5808.912866307009, 5809.912851307234, 4698.671093023456, 4791.209450440708, 4800.855974320776, 4893.951060489349, 4944.579710724557, 3111.2066423061974, 3135.937281254362, 3139.0896639974153, 3153.8896138635037, 3155.952660710045, 5491.752871120809, 5509.807156749494, 5523.6409633373705, 5525.696086715269, 5533.446655334515, 5961.076033214858, 5977.521798256129, 5979.342272350038, 5980.0, 5986.551008674367, 5368.489993450616, 5524.226608274845, 5540.030494663418, 5551.361593416728, 5556.499915007668, 5772.105323674838, 5846.573671926273, 5858.853528661817, 5863.091220860773, 5871.647701137946, 5705.115707065412, 5721.342045664802, 5722.742476588647, 5723.3418156912485, 5724.398938111605, 5351.973240133774, 5511.641743286674, 5541.750621221974, 5550.944490555043, 5553.0837411828215, 3984.960150398575, 4028.073543085048, 4030.2141082488633, 4031.012401961538, 4034.8991275218355, 5792.073268277056, 5795.797147099831, 5796.884062318814, 5802.332731735904, 5805.10020946754, 5556.277683901067, 5597.692126933058, 5599.076152434803, 5599.748011339418, 5602.0196465619165, 5424.457554244544, 5550.139728342114, 5601.131824567198, 5640.153976903333, 5647.463490968352, 5439.891202176013, 5467.45325467466, 5474.233607295061, 5475.753591088331, 5481.479259470344, 5669.433056694463, 5670.546356291405, 5675.091985282335, 5683.119116536944, 5694.658320500783, 5353.304070470814, 5411.458854114557, 5470.398256191736, 5487.204355368529, 5493.121100623881], "unit": "score", "name": "prototype.html", "value": 4197.880331043369}, {"lowerIsBetter": false, "replicates": [770.4799260499161, 784.4626430894841, 789.5933594198989, 799.4084377560607, 800.0439474827582, 11593.362365069917, 12028.999999999989, 12039.75920481591, 12047.457864396101, 12053.939730301357, 10928.945355273212, 10932.016118549329, 10960.671179864597, 10986.121110311176, 10992.890071099286, 607.501848484243, 613.089562000429, 613.8588124731292, 760.8630446519625, 761.394691220481, 773.6247919758913, 774.7985523763833, 776.763087258386, 778.852018116556, 780.9297163255305, 806.6087947345533, 814.0191069760954, 814.7067055859885, 815.2255357410454, 815.4821688227988, 628.7736414890636, 636.805774238857, 802.2819576479077, 817.5299202958263, 818.5048045932185, 602.6986506746626, 603.0321334258496, 603.3242768099713, 603.5955909540618, 604.0817956705827, 11391.259568128127, 11534.826977595343, 11587.420628968517, 11601.593944211912, 11624.767504649859, 10302.484875756258, 10866.293690910066, 11020.889791102067, 11022.834657480063, 11183.04944079746, 9531.475768832712, 9596.136347728669, 9619.086186812241, 9745.976672449433, 9854.753631159207, 3192.5211218317204, 3231.9030429087165, 3253.7397008239286, 3254.869805207789, 3298.208429976812, 39645.20709585792, 39779.0, 39803.601963980276, 40186.19627607431, 40302.39546406806, 9222.584983675752, 9247.907520924704, 9325.720228393158, 9353.485558294358, 9436.150746432853, 16965.915170424316, 16979.405720799714, 16984.660306793794, 17026.914865425595, 17029.063401513034, 6311.936880631135, 6344.080108384258, 6398.968005159944, 6466.418022378009, 6478.902816457757, 3235.094173631387, 3285.244393789442, 3286.0, 3290.6380298167182, 3297.1757060734817, 2452.4481991551756, 2498.5252801967567, 2505.035561308909, 2505.3360859372283, 2506.7367926367833, 436.9104333611602, 444.46220073711174, 449.37761200737214, 451.21038183179434, 451.9977400112978, 446.5289119978389, 448.67471083464227, 457.38253357966477, 494.57466578742253, 512.5591990887833, 7489.737859174903, 7867.9606601966625, 8334.958325208336, 8567.52878591671, 8680.782980425414, 589.6579983609582, 614.8370681769335, 617.6973283091253, 621.7730528357117, 626.580191271849, 3384.6446123157207, 3695.3533131701843, 3717.8113716620674, 3748.306563285801, 3769.962300377016, 48635.75682121567, 48708.0, 48800.0, 48991.51008489869, 51206.74396628067, 43314.35028474576, 43730.0, 44480.77759611181, 44514.554854451686, 44872.10255794866, 40248.396274055915, 40303.798481007405, 40725.79637101855, 40943.0, 40986.79506602448, 7067.0, 7189.856202876018, 7232.493725439169, 7238.420926325986, 7268.126906953218, 29421.705782941895, 29990.25024374408, 30285.394292114474, 30695.0, 30773.23066923345, 35083.0, 35097.0, 35502.28995420129, 35907.46138807972, 39662.0, 9175.541222938693, 9222.769430764285, 9373.1564159226, 9374.109459601326, 9480.857787133336, 10160.136388407069, 10325.285226815555, 10367.43770911135, 10369.066783989478, 10377.792444151226, 9173.174414302744, 9209.815803684023, 9244.399114057565, 9303.209227215491, 9446.85829712541, 9712.562934668098, 9719.27105467107, 9808.852867206855, 9878.802423951625, 9895.307328486937, 9299.814003719752, 9306.813863722553, 9346.579403926975, 9400.529973501434, 9414.246860251027, 8087.63605637736, 8358.62386192635, 8363.247307742333, 8563.058063613122, 8756.168164024408, 8036.4776289541, 8445.028821685339, 8943.776405589912, 9026.323025773225, 9153.725388238363], "unit": "score", "name": "yui.html", "value": 5490.098075935784}], "name": "dromaeo_css", "value": 5969.342756664082}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 109.0, 113.0, 113.0, 113.0, 102.0, 113.0, 113.0, 106.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [161.0, 130.0, 155.0, 192.0, 132.0, 156.0, 164.0, 136.0, 167.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 152.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 164.0, 161.0, 163.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 85.0, 90.0, 76.0, 72.0, 73.0, 99.0, 89.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [99.0, 98.0, 137.0, 97.0, 98.0, 98.0, 133.0, 102.0, 98.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 71.0, 72.0, 72.0, 72.0, 81.0, 68.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 86.0, 85.0, 83.0, 85.0, 97.0, 87.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [125.0, 138.0, 122.0, 118.0, 120.0, 121.0, 127.0, 129.0, 121.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [135.0, 149.0, 147.0, 146.0, 148.0, 136.0, 146.0, 146.0, 147.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 73.0, 73.0, 71.0, 69.0, 71.0, 70.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1532.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.16816218012627], "unit": "score", "name": "Richards", "value": 212.4474360000001}, {"lowerIsBetter": false, "replicates": [188.00526414739613], "unit": "score", "name": "DeltaBlue", "value": 351.68164199999995}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [2018.1451612903227], "unit": "score", "name": "RayTrace", "value": 366.667876123876}, {"lowerIsBetter": false, "replicates": [831.9467554076539], "unit": "score", "name": "Earley", "value": 801.0885260000002}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [26710.526315789473], "unit": "score", "name": "RegExp", "value": 34.105842364532016}, {"lowerIsBetter": false, "replicates": [615.7635467980296], "unit": "score", "name": "Splay", "value": 132.34138400000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19587.904353303158}]} 08:39:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19587.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1532.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "5969.34"}}} 08:39:37 INFO - Return code: 0 08:39:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:39:37 INFO - # TBPL SUCCESS # 08:39:37 INFO - Running post-action listener: _resource_record_post_action 08:39:37 INFO - Running post-run listener: _resource_record_post_run 08:39:38 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 0; Write bytes: 564940800; Read time: 0; Write time: 725156 08:39:38 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 244699136; Read time: 0; Write time: 342044 08:39:38 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 316026880; Read time: 0; Write time: 382580 08:39:38 INFO - Running post-run listener: _upload_blobber_files 08:39:38 INFO - Blob upload gear active. 08:39:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:39:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'B2G-Inbound-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b B2G-Inbound-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:39:38 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:39:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:39:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:39 INFO - (blobuploader) - INFO - Done attempting. 08:39:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:39:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:39:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:40 INFO - (blobuploader) - INFO - Done attempting. 08:39:40 INFO - (blobuploader) - INFO - Iteration through files over. 08:39:40 INFO - Return code: 0 08:39:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:39:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:39:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/85f1b310911249958af990d1a8a2d21c84ef753fff13398e1fa232bd13f15bcdb1c4a421e05e3c21604ffdda2cc517bf776001aec18d6752ffa7301ca5cca92e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/d5b1b4bbde82dcee40e825e26c2761eb0b3367335dfbd61d75691f441ab5cc62bb9a50fb86326ae64a4fc4d3f689b374db811aea99f547b212a3ba3105f65f4f"} 08:39:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:39:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:39:40 INFO - Contents: 08:39:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/85f1b310911249958af990d1a8a2d21c84ef753fff13398e1fa232bd13f15bcdb1c4a421e05e3c21604ffdda2cc517bf776001aec18d6752ffa7301ca5cca92e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/d5b1b4bbde82dcee40e825e26c2761eb0b3367335dfbd61d75691f441ab5cc62bb9a50fb86326ae64a4fc4d3f689b374db811aea99f547b212a3ba3105f65f4f"} 08:39:40 INFO - Copying logs to upload dir... 08:39:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.244327 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-07 08:39:39.878823) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 08:39:39.882255) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654 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/85f1b310911249958af990d1a8a2d21c84ef753fff13398e1fa232bd13f15bcdb1c4a421e05e3c21604ffdda2cc517bf776001aec18d6752ffa7301ca5cca92e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/d5b1b4bbde82dcee40e825e26c2761eb0b3367335dfbd61d75691f441ab5cc62bb9a50fb86326ae64a4fc4d3f689b374db811aea99f547b212a3ba3105f65f4f"} build_url:https://queue.taskcluster.net/v1/task/YEKrqUe9QjanEPq1IE7qtQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/YEKrqUe9QjanEPq1IE7qtQ/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/85f1b310911249958af990d1a8a2d21c84ef753fff13398e1fa232bd13f15bcdb1c4a421e05e3c21604ffdda2cc517bf776001aec18d6752ffa7301ca5cca92e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/d5b1b4bbde82dcee40e825e26c2761eb0b3367335dfbd61d75691f441ab5cc62bb9a50fb86326ae64a4fc4d3f689b374db811aea99f547b212a3ba3105f65f4f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 08:39:39.907493) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:39:39.907939) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452182518.709812-1979515654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 08:39:39.993886) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 08:39:39.994238) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 08:39:39.994580) ========= ========= Total master_lag: 0.27 =========