builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1452859890.76 results: success (0) buildid: 20160115023944 builduid: 48b446f193104d25b42cf24a037b7545 revision: 7a91754ea08371fd44cf4842d12f5e64841a38aa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:30.759587) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:30.760076) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:30.760380) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006207 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:30.783556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:30.783900) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:30.799291) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:30.799722) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.18 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:30.983974) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:30.984294) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:30.984711) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:30.984989) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 04:11:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-01-15 04:11:31 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189522 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:31.328265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:31.328604) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020555 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:31.361404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:31.361769) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7a91754ea08371fd44cf4842d12f5e64841a38aa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7a91754ea08371fd44cf4842d12f5e64841a38aa --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=20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 04:11:31,749 truncating revision to first 12 chars 2016-01-15 04:11:31,749 Setting DEBUG logging. 2016-01-15 04:11:31,750 attempt 1/10 2016-01-15 04:11:31,750 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7a91754ea083?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 04:11:32,020 unpacking tar archive at: mozilla-central-7a91754ea083/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584306 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:31.959516) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:31.959832) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:31.970914) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:31.971250) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 04:11:31.971709) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-15 04:11:31.971994) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:11:32 INFO - MultiFileLogger online at 20160115 04:11:32 in /builds/slave/test 04:11:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:11:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:11:32 INFO - {'append_to_log': False, 04:11:32 INFO - 'base_work_dir': '/builds/slave/test', 04:11:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:11:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:11:32 INFO - 'branch': 'Firefox-Non-PGO', 04:11:32 INFO - 'buildbot_json_path': 'buildprops.json', 04:11:32 INFO - 'config_files': ('talos/linux_config.py',), 04:11:32 INFO - 'default_actions': ('clobber', 04:11:32 INFO - 'read-buildbot-config', 04:11:32 INFO - 'download-and-extract', 04:11:32 INFO - 'populate-webroot', 04:11:32 INFO - 'create-virtualenv', 04:11:32 INFO - 'install', 04:11:32 INFO - 'run-tests'), 04:11:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:11:32 INFO - 'download_minidump_stackwalk': True, 04:11:32 INFO - 'download_symbols': 'ondemand', 04:11:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:11:32 INFO - 'tooltool.py': '/tools/tooltool.py', 04:11:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:11:32 INFO - '/tools/misc-python/virtualenv.py')}, 04:11:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:11:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:11:32 INFO - 'installer_path': 'installer.exe', 04:11:32 INFO - 'log_level': 'info', 04:11:32 INFO - 'log_name': 'talos', 04:11:32 INFO - 'log_to_console': True, 04:11:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:11:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:11:32 INFO - 'opt_config_files': (), 04:11:32 INFO - 'pip_index': False, 04:11:32 INFO - 'sps_profile': False, 04:11:32 INFO - 'sps_profile_interval': 0, 04:11:32 INFO - 'suite': 'dromaeojs-e10s', 04:11:32 INFO - 'system_bits': '32', 04:11:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:11:32 INFO - 'title': 'talos-linux64-ix-015', 04:11:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:11:32 INFO - 'use_talos_json': True, 04:11:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:11:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:11:32 INFO - 'work_dir': 'build'} 04:11:32 INFO - ##### 04:11:32 INFO - ##### Running clobber step. 04:11:32 INFO - ##### 04:11:32 INFO - Running pre-action listener: _resource_record_pre_action 04:11:32 INFO - Running main action method: clobber 04:11:32 INFO - rmtree: /builds/slave/test/build 04:11:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:11:32 INFO - Running post-action listener: _resource_record_post_action 04:11:32 INFO - ##### 04:11:32 INFO - ##### Running read-buildbot-config step. 04:11:32 INFO - ##### 04:11:32 INFO - Running pre-action listener: _resource_record_pre_action 04:11:32 INFO - Running main action method: read_buildbot_config 04:11:32 INFO - Using buildbot properties: 04:11:32 INFO - { 04:11:32 INFO - "project": "", 04:11:32 INFO - "product": "firefox", 04:11:32 INFO - "script_repo_revision": "production", 04:11:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:11:32 INFO - "repository": "", 04:11:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:11:32 INFO - "buildid": "20160115023944", 04:11:32 INFO - "pgo_build": "False", 04:11:32 INFO - "basedir": "/builds/slave/test", 04:11:32 INFO - "buildnumber": 174, 04:11:32 INFO - "slavename": "talos-linux64-ix-015", 04:11:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:11:32 INFO - "platform": "ubuntu64_hw", 04:11:32 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:11:32 INFO - "branch": "mozilla-central", 04:11:32 INFO - "repo_path": "mozilla-central", 04:11:32 INFO - "revision": "7a91754ea08371fd44cf4842d12f5e64841a38aa", 04:11:32 INFO - "stage_platform": "linux64", 04:11:32 INFO - "builduid": "48b446f193104d25b42cf24a037b7545", 04:11:32 INFO - "slavebuilddir": "test" 04:11:32 INFO - } 04:11:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:11:32 INFO - Running post-action listener: _resource_record_post_action 04:11:32 INFO - ##### 04:11:32 INFO - ##### Running download-and-extract step. 04:11:32 INFO - ##### 04:11:32 INFO - Running pre-action listener: _resource_record_pre_action 04:11:32 INFO - Running main action method: download_and_extract 04:11:32 INFO - mkdir: /builds/slave/test/build/tests 04:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:32 INFO - https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:11:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/test_packages.json 04:11:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/test_packages.json 04:11:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:11:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:11:33 INFO - Downloaded 1448 bytes. 04:11:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:11:33 INFO - Using the following test package requirements: 04:11:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:11:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:11:33 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:11:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:33 INFO - u'jsshell-linux-x86_64.zip'], 04:11:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:11:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:11:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:11:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:11:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:11:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:11:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:11:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:33 INFO - https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:11:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:11:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:11:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:11:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:11:36 INFO - Downloaded 21170719 bytes. 04:11:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:11:37 INFO - Return code: 0 04:11:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:37 INFO - https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:11:40 INFO - Downloaded 21170719 bytes. 04:11:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:11:41 INFO - Return code: 0 04:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:41 INFO - https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:11:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:11:44 INFO - Downloaded 11132144 bytes. 04:11:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:11:44 INFO - Return code: 0 04:11: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')]} 04:11:44 INFO - https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:11:47 INFO - Downloaded 54213802 bytes. 04:11:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:11:47 INFO - mkdir: /builds/slave/test/properties 04:11:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:47 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:47 INFO - Contents: 04:11:47 INFO - build_url:https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:11:47 INFO - Running post-action listener: _resource_record_post_action 04:11:47 INFO - Running post-action listener: set_extra_try_arguments 04:11:47 INFO - ##### 04:11:47 INFO - ##### Running populate-webroot step. 04:11:47 INFO - ##### 04:11:47 INFO - Running pre-action listener: _resource_record_pre_action 04:11:47 INFO - Running main action method: populate_webroot 04:11:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:11:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:11:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:11:47 INFO - '--tppagecycles', 04:11:47 INFO - '7'], 04:11:47 INFO - 'tests': ['tsvgm']}}, 04:11:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:11:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:11:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:11:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:11:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:11:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:11:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:47 INFO - 'talos_options': ['--e10s'], 04:11:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:47 INFO - 'tests': ['damp', 'tps']}, 04:11:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:47 INFO - 'talos_options': ['--e10s'], 04:11:47 INFO - 'tests': ['damp', 'tps']}, 04:11:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:11:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:47 INFO - 'other': {'tests': ['a11yr', 04:11:47 INFO - 'ts_paint', 04:11:47 INFO - 'tpaint', 04:11:47 INFO - 'sessionrestore', 04:11:47 INFO - 'sessionrestore_no_auto_restore']}, 04:11:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:11:47 INFO - 'tests': ['a11yr', 04:11:47 INFO - 'ts_paint', 04:11:47 INFO - 'tpaint', 04:11:47 INFO - 'sessionrestore', 04:11:47 INFO - 'sessionrestore_no_auto_restore']}, 04:11:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:11:47 INFO - 'tests': ['a11yr', 04:11:47 INFO - 'ts_paint', 04:11:47 INFO - 'tpaint', 04:11:47 INFO - 'sessionrestore', 04:11:47 INFO - 'sessionrestore_no_auto_restore']}, 04:11:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:11:47 INFO - 'tests': ['a11yr', 04:11:47 INFO - 'ts_paint', 04:11:47 INFO - 'tpaint', 04:11:47 INFO - 'sessionrestore', 04:11:47 INFO - 'sessionrestore_no_auto_restore']}, 04:11:47 INFO - 'other_l64': {'tests': ['a11yr', 04:11:47 INFO - 'ts_paint', 04:11:47 INFO - 'tpaint', 04:11:47 INFO - 'sessionrestore', 04:11:47 INFO - 'sessionrestore_no_auto_restore']}, 04:11:47 INFO - 'other_nol64': {'tests': ['a11yr', 04:11:47 INFO - 'ts_paint', 04:11:47 INFO - 'tpaint', 04:11:47 INFO - 'sessionrestore', 04:11:47 INFO - 'sessionrestore_no_auto_restore']}, 04:11:47 INFO - 'svgr': {'tests': ['tsvgx', 04:11:47 INFO - 'tsvgr_opacity', 04:11:47 INFO - 'tart', 04:11:47 INFO - 'tscrollx', 04:11:47 INFO - 'cart']}, 04:11:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:11:47 INFO - 'tests': ['tsvgx', 04:11:47 INFO - 'tsvgr_opacity', 04:11:47 INFO - 'tart', 04:11:47 INFO - 'tscrollx', 04:11:47 INFO - 'cart']}, 04:11:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:47 INFO - 'tests': ['tp5o']}, 04:11:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:47 INFO - 'talos_options': ['--e10s'], 04:11:47 INFO - 'tests': ['tp5o']}, 04:11:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:47 INFO - 'talos_options': ['--xperf_path', 04:11:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:47 INFO - 'tests': ['tp5n']}, 04:11:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:47 INFO - 'talos_options': ['--e10s', 04:11:47 INFO - '--xperf_path', 04:11:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:47 INFO - 'tests': ['tp5n']}}, 04:11:47 INFO - 'talos.zip': {'path': '', 04:11:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:11:47 INFO - Running post-action listener: _resource_record_post_action 04:11:47 INFO - ##### 04:11:47 INFO - ##### Running create-virtualenv step. 04:11:47 INFO - ##### 04:11:47 INFO - Running pre-action listener: _resource_record_pre_action 04:11:47 INFO - Running main action method: create_virtualenv 04:11:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:11:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:47 INFO - Using real prefix '/usr' 04:11:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:49 INFO - Installing pip.................done. 04:11:49 INFO - Return code: 0 04:11:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:49 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 0x7f06e5004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e3d0>, '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 0x2309ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230a360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:11:49 INFO - Using env: {'DISPLAY': ':0', 04:11:49 INFO - 'HOME': '/home/cltbld', 04:11:49 INFO - 'LANG': 'en_US.UTF-8', 04:11:49 INFO - 'LANGUAGE': 'en_US:en', 04:11:49 INFO - 'LOGNAME': 'cltbld', 04:11:49 INFO - 'MAIL': '/var/mail/cltbld', 04:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:49 INFO - 'MOZ_NO_REMOTE': '1', 04:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:49 INFO - 'NO_EM_RESTART': '1', 04:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:49 INFO - 'PWD': '/builds/slave/test', 04:11:49 INFO - 'SHELL': '/bin/bash', 04:11:49 INFO - 'SHLVL': '1', 04:11:49 INFO - 'TERM': 'linux', 04:11:49 INFO - 'TMOUT': '86400', 04:11:49 INFO - 'USER': 'cltbld', 04:11:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 04:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:49 INFO - '_': '/tools/buildbot/bin/python'} 04:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:11:50 INFO - Cleaning up... 04:11:50 INFO - Return code: 0 04:11:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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', '--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 0x7f06e5004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e3d0>, '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 0x2309ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230a360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:11:50 INFO - Using env: {'DISPLAY': ':0', 04:11:50 INFO - 'HOME': '/home/cltbld', 04:11:50 INFO - 'LANG': 'en_US.UTF-8', 04:11:50 INFO - 'LANGUAGE': 'en_US:en', 04:11:50 INFO - 'LOGNAME': 'cltbld', 04:11:50 INFO - 'MAIL': '/var/mail/cltbld', 04:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:50 INFO - 'MOZ_NO_REMOTE': '1', 04:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:50 INFO - 'NO_EM_RESTART': '1', 04:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:50 INFO - 'PWD': '/builds/slave/test', 04:11:50 INFO - 'SHELL': '/bin/bash', 04:11:50 INFO - 'SHLVL': '1', 04:11:50 INFO - 'TERM': 'linux', 04:11:50 INFO - 'TMOUT': '86400', 04:11:50 INFO - 'USER': 'cltbld', 04:11:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 04:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:50 INFO - '_': '/tools/buildbot/bin/python'} 04:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:50 INFO - Downloading/unpacking psutil>=0.7.1 04:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:11:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:52 INFO - Installing collected packages: psutil 04:11:52 INFO - Running setup.py install for psutil 04:11:52 INFO - building 'psutil._psutil_linux' extension 04:11:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:11:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:11:52 INFO - building 'psutil._psutil_posix' extension 04:11:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:11:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:52 INFO - Successfully installed psutil 04:11:52 INFO - Cleaning up... 04:11:52 INFO - Return code: 0 04:11:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:52 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 0x7f06e5004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e3d0>, '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 0x2309ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230a360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:11:52 INFO - Using env: {'DISPLAY': ':0', 04:11:52 INFO - 'HOME': '/home/cltbld', 04:11:52 INFO - 'LANG': 'en_US.UTF-8', 04:11:52 INFO - 'LANGUAGE': 'en_US:en', 04:11:52 INFO - 'LOGNAME': 'cltbld', 04:11:52 INFO - 'MAIL': '/var/mail/cltbld', 04:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:52 INFO - 'MOZ_NO_REMOTE': '1', 04:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:52 INFO - 'NO_EM_RESTART': '1', 04:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:52 INFO - 'PWD': '/builds/slave/test', 04:11:52 INFO - 'SHELL': '/bin/bash', 04:11:52 INFO - 'SHLVL': '1', 04:11:52 INFO - 'TERM': 'linux', 04:11:52 INFO - 'TMOUT': '86400', 04:11:52 INFO - 'USER': 'cltbld', 04:11:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 04:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:52 INFO - '_': '/tools/buildbot/bin/python'} 04:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:11:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:11:54 INFO - Installing collected packages: mozsystemmonitor 04:11:54 INFO - Running setup.py install for mozsystemmonitor 04:11:54 INFO - Successfully installed mozsystemmonitor 04:11:54 INFO - Cleaning up... 04:11:54 INFO - Return code: 0 04:11:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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', '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 0x7f06e5004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e3d0>, '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 0x2309ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230a360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:11: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 blobuploader==1.2.4 04:11:54 INFO - Using env: {'DISPLAY': ':0', 04:11:54 INFO - 'HOME': '/home/cltbld', 04:11:54 INFO - 'LANG': 'en_US.UTF-8', 04:11:54 INFO - 'LANGUAGE': 'en_US:en', 04:11:54 INFO - 'LOGNAME': 'cltbld', 04:11:54 INFO - 'MAIL': '/var/mail/cltbld', 04:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:54 INFO - 'MOZ_NO_REMOTE': '1', 04:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:54 INFO - 'NO_EM_RESTART': '1', 04:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:54 INFO - 'PWD': '/builds/slave/test', 04:11:54 INFO - 'SHELL': '/bin/bash', 04:11:54 INFO - 'SHLVL': '1', 04:11:54 INFO - 'TERM': 'linux', 04:11:54 INFO - 'TMOUT': '86400', 04:11:54 INFO - 'USER': 'cltbld', 04:11:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 04:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:54 INFO - '_': '/tools/buildbot/bin/python'} 04:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11:56 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11:57 INFO - Downloading docopt-0.6.1.tar.gz 04:11:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:57 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:57 INFO - Running setup.py install for blobuploader 04:11:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:57 INFO - Running setup.py install for requests 04:11:57 INFO - Running setup.py install for docopt 04:11:57 INFO - Successfully installed blobuploader requests docopt 04:11:57 INFO - Cleaning up... 04:11:57 INFO - Return code: 0 04:11:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:57 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 0x7f06e5004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e3d0>, '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 0x2309ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230a360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:11:57 INFO - Using env: {'DISPLAY': ':0', 04:11:57 INFO - 'HOME': '/home/cltbld', 04:11:57 INFO - 'LANG': 'en_US.UTF-8', 04:11:57 INFO - 'LANGUAGE': 'en_US:en', 04:11:57 INFO - 'LOGNAME': 'cltbld', 04:11:57 INFO - 'MAIL': '/var/mail/cltbld', 04:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:57 INFO - 'MOZ_NO_REMOTE': '1', 04:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:57 INFO - 'NO_EM_RESTART': '1', 04:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:57 INFO - 'PWD': '/builds/slave/test', 04:11:57 INFO - 'SHELL': '/bin/bash', 04:11:57 INFO - 'SHLVL': '1', 04:11:57 INFO - 'TERM': 'linux', 04:11:57 INFO - 'TMOUT': '86400', 04:11:57 INFO - 'USER': 'cltbld', 04:11:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 04:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:57 INFO - '_': '/tools/buildbot/bin/python'} 04:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:58 INFO - Running setup.py (path:/tmp/pip-cnALTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:58 INFO - Running setup.py (path:/tmp/pip-aXKoP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:58 INFO - Running setup.py (path:/tmp/pip-f8tLQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:58 INFO - Running setup.py (path:/tmp/pip-NnicAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:58 INFO - Running setup.py (path:/tmp/pip-1WfSQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:58 INFO - Running setup.py (path:/tmp/pip-zLqCck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:58 INFO - Running setup.py (path:/tmp/pip-1_OuBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:58 INFO - Running setup.py (path:/tmp/pip-F8Omnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:58 INFO - Running setup.py (path:/tmp/pip-dLcYNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:58 INFO - Running setup.py (path:/tmp/pip-cuGHQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:58 INFO - Running setup.py (path:/tmp/pip-h_Thnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:58 INFO - Running setup.py (path:/tmp/pip-M2YMHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:59 INFO - Running setup.py (path:/tmp/pip-x8lz9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:59 INFO - Running setup.py (path:/tmp/pip-BE32f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:59 INFO - Running setup.py (path:/tmp/pip-brjn_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:59 INFO - Running setup.py (path:/tmp/pip-8qcCpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:59 INFO - Running setup.py (path:/tmp/pip-ejN3BX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:11:59 INFO - Running setup.py install for manifestparser 04:11:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:11:59 INFO - Running setup.py install for mozcrash 04:11:59 INFO - Running setup.py install for mozdebug 04:11:59 INFO - Running setup.py install for mozdevice 04:11:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:11:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:11:59 INFO - Running setup.py install for mozfile 04:11:59 INFO - Running setup.py install for mozhttpd 04:11:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:11:59 INFO - Running setup.py install for mozinfo 04:12:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Running setup.py install for mozInstall 04:12:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Running setup.py install for mozleak 04:12:00 INFO - Running setup.py install for mozlog 04:12:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Running setup.py install for moznetwork 04:12:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Running setup.py install for mozprocess 04:12:00 INFO - Running setup.py install for mozprofile 04:12:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Running setup.py install for mozrunner 04:12:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:12:00 INFO - Running setup.py install for mozscreenshot 04:12:00 INFO - Running setup.py install for moztest 04:12:01 INFO - Running setup.py install for mozversion 04:12:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:12:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:12:01 INFO - Cleaning up... 04:12:01 INFO - Return code: 0 04:12:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:01 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 0x7f06e5004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e3d0>, '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 0x2309ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230a360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:12:01 INFO - Using env: {'DISPLAY': ':0', 04:12:01 INFO - 'HOME': '/home/cltbld', 04:12:01 INFO - 'LANG': 'en_US.UTF-8', 04:12:01 INFO - 'LANGUAGE': 'en_US:en', 04:12:01 INFO - 'LOGNAME': 'cltbld', 04:12:01 INFO - 'MAIL': '/var/mail/cltbld', 04:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:01 INFO - 'MOZ_NO_REMOTE': '1', 04:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:01 INFO - 'NO_EM_RESTART': '1', 04:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:01 INFO - 'PWD': '/builds/slave/test', 04:12:01 INFO - 'SHELL': '/bin/bash', 04:12:01 INFO - 'SHLVL': '1', 04:12:01 INFO - 'TERM': 'linux', 04:12:01 INFO - 'TMOUT': '86400', 04:12:01 INFO - 'USER': 'cltbld', 04:12:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 04:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:01 INFO - '_': '/tools/buildbot/bin/python'} 04:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:01 INFO - Running setup.py (path:/tmp/pip-CmlNXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:01 INFO - Running setup.py (path:/tmp/pip-R7sFfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:01 INFO - Running setup.py (path:/tmp/pip-Eov2Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:01 INFO - Running setup.py (path:/tmp/pip-REA3od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:01 INFO - Running setup.py (path:/tmp/pip-SvtaOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:01 INFO - Running setup.py (path:/tmp/pip-pYW4Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:01 INFO - Running setup.py (path:/tmp/pip-8wmWd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:01 INFO - Running setup.py (path:/tmp/pip-pWssbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:01 INFO - Running setup.py (path:/tmp/pip-CKQLWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:02 INFO - Running setup.py (path:/tmp/pip-2hYDgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:02 INFO - Running setup.py (path:/tmp/pip-lO_bmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:02 INFO - Running setup.py (path:/tmp/pip-Syvwlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:02 INFO - Running setup.py (path:/tmp/pip-WvuNN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:02 INFO - Running setup.py (path:/tmp/pip-oViUKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:02 INFO - Running setup.py (path:/tmp/pip-wgKn4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:02 INFO - Running setup.py (path:/tmp/pip-0K4tyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:02 INFO - Running setup.py (path:/tmp/pip-8BXhKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:04 INFO - Downloading blessings-1.5.1.tar.gz 04:12:04 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:12:04 INFO - Installing collected packages: blessings 04:12:04 INFO - Running setup.py install for blessings 04:12:04 INFO - Successfully installed blessings 04:12:04 INFO - Cleaning up... 04:12:04 INFO - Return code: 0 04:12:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:04 INFO - Reading from file tmpfile_stdout 04:12:04 INFO - Current package versions: 04:12:04 INFO - argparse == 1.2.1 04:12:04 INFO - blessings == 1.5.1 04:12:04 INFO - blobuploader == 1.2.4 04:12:04 INFO - docopt == 0.6.1 04:12:04 INFO - manifestparser == 1.1 04:12:04 INFO - mozInstall == 1.12 04:12:04 INFO - mozcrash == 0.16 04:12:04 INFO - mozdebug == 0.1 04:12:04 INFO - mozdevice == 0.48 04:12:04 INFO - mozfile == 1.2 04:12:04 INFO - mozhttpd == 0.7 04:12:04 INFO - mozinfo == 0.9 04:12:04 INFO - mozleak == 0.1 04:12:04 INFO - mozlog == 3.1 04:12:04 INFO - moznetwork == 0.27 04:12:04 INFO - mozprocess == 0.22 04:12:04 INFO - mozprofile == 0.28 04:12:04 INFO - mozrunner == 6.11 04:12:04 INFO - mozscreenshot == 0.1 04:12:04 INFO - mozsystemmonitor == 0.0 04:12:04 INFO - moztest == 0.7 04:12:04 INFO - mozversion == 1.4 04:12:04 INFO - psutil == 3.1.1 04:12:04 INFO - requests == 1.2.3 04:12:04 INFO - wsgiref == 0.1.2 04:12:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:04 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 0x7f06e5004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e3d0>, '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 0x2309ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230a360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:12:04 INFO - Using env: {'DISPLAY': ':0', 04:12:04 INFO - 'HOME': '/home/cltbld', 04:12:04 INFO - 'LANG': 'en_US.UTF-8', 04:12:04 INFO - 'LANGUAGE': 'en_US:en', 04:12:04 INFO - 'LOGNAME': 'cltbld', 04:12:04 INFO - 'MAIL': '/var/mail/cltbld', 04:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:04 INFO - 'MOZ_NO_REMOTE': '1', 04:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:04 INFO - 'NO_EM_RESTART': '1', 04:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:04 INFO - 'PWD': '/builds/slave/test', 04:12:04 INFO - 'SHELL': '/bin/bash', 04:12:04 INFO - 'SHLVL': '1', 04:12:04 INFO - 'TERM': 'linux', 04:12:04 INFO - 'TMOUT': '86400', 04:12:04 INFO - 'USER': 'cltbld', 04:12:04 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 04:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:04 INFO - '_': '/tools/buildbot/bin/python'} 04:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:12:04 INFO - Cleaning up... 04:12:05 INFO - Return code: 0 04:12:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06e5004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e3d0>, '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 0x2309ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230a360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:12:05 INFO - Using env: {'DISPLAY': ':0', 04:12:05 INFO - 'HOME': '/home/cltbld', 04:12:05 INFO - 'LANG': 'en_US.UTF-8', 04:12:05 INFO - 'LANGUAGE': 'en_US:en', 04:12:05 INFO - 'LOGNAME': 'cltbld', 04:12:05 INFO - 'MAIL': '/var/mail/cltbld', 04:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:05 INFO - 'MOZ_NO_REMOTE': '1', 04:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:05 INFO - 'NO_EM_RESTART': '1', 04:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:05 INFO - 'PWD': '/builds/slave/test', 04:12:05 INFO - 'SHELL': '/bin/bash', 04:12:05 INFO - 'SHLVL': '1', 04:12:05 INFO - 'TERM': 'linux', 04:12:05 INFO - 'TMOUT': '86400', 04:12:05 INFO - 'USER': 'cltbld', 04:12:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 04:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:05 INFO - '_': '/tools/buildbot/bin/python'} 04:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:05 INFO - Downloading/unpacking jsonschema 04:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:12:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:12:06 INFO - Downloading/unpacking functools32 (from jsonschema) 04:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:07 INFO - Downloading functools32-3.2.3-2.tar.gz 04:12:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:12:07 INFO - warning: no files found matching '*.txt' 04:12:07 INFO - no previously-included directories found matching 'build' 04:12:07 INFO - no previously-included directories found matching 'dist' 04:12:07 INFO - no previously-included directories found matching '.git*' 04:12:07 INFO - Installing collected packages: jsonschema, functools32 04:12:07 INFO - Running setup.py install for functools32 04:12:07 INFO - warning: no files found matching '*.txt' 04:12:07 INFO - no previously-included directories found matching 'build' 04:12:07 INFO - no previously-included directories found matching 'dist' 04:12:07 INFO - no previously-included directories found matching '.git*' 04:12:07 INFO - Successfully installed jsonschema functools32 04:12:07 INFO - Cleaning up... 04:12:07 INFO - Return code: 0 04:12:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:07 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 0x7f06e5004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e3d0>, '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 0x2309ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230a360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:12:07 INFO - Using env: {'DISPLAY': ':0', 04:12:07 INFO - 'HOME': '/home/cltbld', 04:12:07 INFO - 'LANG': 'en_US.UTF-8', 04:12:07 INFO - 'LANGUAGE': 'en_US:en', 04:12:07 INFO - 'LOGNAME': 'cltbld', 04:12:07 INFO - 'MAIL': '/var/mail/cltbld', 04:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:07 INFO - 'MOZ_NO_REMOTE': '1', 04:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:07 INFO - 'NO_EM_RESTART': '1', 04:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:07 INFO - 'PWD': '/builds/slave/test', 04:12:07 INFO - 'SHELL': '/bin/bash', 04:12:07 INFO - 'SHLVL': '1', 04:12:07 INFO - 'TERM': 'linux', 04:12:07 INFO - 'TMOUT': '86400', 04:12:07 INFO - 'USER': 'cltbld', 04:12:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 04:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:07 INFO - '_': '/tools/buildbot/bin/python'} 04:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:07 INFO - Downloading/unpacking flake8 04:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:12:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:12:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:12:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:12:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:12:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:12:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:12:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:12:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:12:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:12:10 INFO - no previously-included directories found matching 'docs/_build' 04:12:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:12:10 INFO - Running setup.py install for pep8 04:12:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:12:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:12:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:12:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:12:10 INFO - no previously-included directories found matching 'docs/_build' 04:12:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:12:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:12:10 INFO - Cleaning up... 04:12:10 INFO - Return code: 0 04:12:10 INFO - Running post-action listener: _resource_record_post_action 04:12:10 INFO - Running post-action listener: _start_resource_monitoring 04:12:10 INFO - Starting resource monitoring. 04:12:10 INFO - ##### 04:12:10 INFO - ##### Running install step. 04:12:10 INFO - ##### 04:12:10 INFO - Running pre-action listener: _resource_record_pre_action 04:12:10 INFO - Running main action method: install 04:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:10 INFO - Reading from file tmpfile_stdout 04:12:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:12:10 INFO - Reading from file tmpfile_stdout 04:12:10 INFO - Output received: 04:12:10 INFO - Usage: mozinstall [options] installer 04:12:10 INFO - Options: 04:12:10 INFO - -h, --help show this help message and exit 04:12:10 INFO - -d DEST, --destination=DEST 04:12:10 INFO - Directory to install application into. [default: 04:12:10 INFO - "/builds/slave/test"] 04:12:10 INFO - --app=APP Application being installed. [default: firefox] 04:12:10 INFO - mkdir: /builds/slave/test/build/application 04:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:12:26 INFO - Reading from file tmpfile_stdout 04:12:26 INFO - Output received: 04:12:26 INFO - /builds/slave/test/build/application/firefox/firefox 04:12:26 INFO - Running post-action listener: _resource_record_post_action 04:12:26 INFO - ##### 04:12:26 INFO - ##### Running run-tests step. 04:12:26 INFO - ##### 04:12:26 INFO - Running pre-action listener: _resource_record_pre_action 04:12:26 INFO - Running main action method: run_tests 04:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:12:26 INFO - Python 2.7.3 04:12:26 INFO - Return code: 0 04:12:26 INFO - grabbing minidump binary from tooltool 04:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:26 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 0x239e3d0>, '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 0x2309ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230a360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:12:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:12:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:12:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:12:26 INFO - Return code: 0 04:12:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:12:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:12:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:12:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:12:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:12:27 INFO - Return code: 0 04:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:12:27 INFO - Using env: {'DISPLAY': ':0', 04:12:27 INFO - 'HOME': '/home/cltbld', 04:12:27 INFO - 'LANG': 'en_US.UTF-8', 04:12:27 INFO - 'LANGUAGE': 'en_US:en', 04:12:27 INFO - 'LOGNAME': 'cltbld', 04:12:27 INFO - 'MAIL': '/var/mail/cltbld', 04:12:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:27 INFO - 'MOZ_NO_REMOTE': '1', 04:12:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:27 INFO - 'NO_EM_RESTART': '1', 04:12:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:27 INFO - 'PWD': '/builds/slave/test', 04:12:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:27 INFO - 'SHELL': '/bin/bash', 04:12:27 INFO - 'SHLVL': '1', 04:12:27 INFO - 'TERM': 'linux', 04:12:27 INFO - 'TMOUT': '86400', 04:12:27 INFO - 'USER': 'cltbld', 04:12:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157', 04:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:27 INFO - '_': '/tools/buildbot/bin/python'} 04:12:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:12:27 INFO - mozversion application_buildid: 20160115023944 04:12:27 INFO - mozversion application_changeset: 7a91754ea08371fd44cf4842d12f5e64841a38aa 04:12:27 INFO - mozversion application_display_name: Nightly 04:12:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:12:27 INFO - mozversion application_name: Firefox 04:12:27 INFO - mozversion application_remotingname: firefox 04:12:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:12:27 INFO - mozversion application_vendor: Mozilla 04:12:27 INFO - mozversion application_version: 46.0a1 04:12:27 INFO - mozversion platform_buildid: 20160115023944 04:12:27 INFO - mozversion platform_changeset: 7a91754ea08371fd44cf4842d12f5e64841a38aa 04:12:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:12:27 INFO - mozversion platform_version: 46.0a1 04:12:27 INFO - using testdate: 1452859947 04:12:27 INFO - actual date: 1452859947 04:12:27 INFO - starting webserver on 'localhost:51535' 04:12:27 INFO - SUITE-START | Running 3 tests 04:12:27 INFO - TEST-START | dromaeo_css 04:12:27 INFO - operating with platform_type : linux_ 04:12:27 INFO - Initialising browser for dromaeo_css test... 04:12:27 INFO - TEST-INFO | started process 24109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJtBps2/profile http://localhost:51535/getInfo.html) 04:12:31 INFO - PROCESS | 24109 | 04:12:31 INFO - PROCESS | 24109 | (process:24193): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:12:32 INFO - PROCESS | 24109 | __metrics Screen width/height:1600/1200 04:12:32 INFO - PROCESS | 24109 | colorDepth:24 04:12:32 INFO - PROCESS | 24109 | Browser inner width/height: 1024/697 04:12:32 INFO - PROCESS | 24109 | __metrics 04:12:32 INFO - PROCESS | 24109 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:12:33 INFO - TEST-INFO | 24109: exit 0 04:12:33 INFO - Browser initialized. 04:12:33 INFO - Running cycle 1/1 for dromaeo_css test... 04:12:33 INFO - TEST-INFO | started process 24242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJtBps2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:34 INFO - PROCESS | 24242 | 04:12:34 INFO - PROCESS | 24242 | (process:24299): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:12:45 INFO - PROCESS | 24242 | RSS: Main: 150515712 04:12:45 INFO - PROCESS | 24242 | 04:13:34 INFO - PROCESS | 24242 | 1452860014685 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:15:46 INFO - PROCESS | 24242 | Cycle 1(1): loaded http://localhost:51535/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51535/tests/dromaeo/cssquery-ext.html) 04:15:47 INFO - PROCESS | 24242 | RSS: Main: 156336128 04:15:47 INFO - PROCESS | 24242 | 04:18:49 INFO - PROCESS | 24242 | Cycle 1(1): loaded http://localhost:51535/tests/dromaeo/cssquery-ext.html (next: http://localhost:51535/tests/dromaeo/cssquery-jquery.html) 04:18:49 INFO - PROCESS | 24242 | RSS: Main: 150949888 04:18:49 INFO - PROCESS | 24242 | 04:21:51 INFO - PROCESS | 24242 | Cycle 1(1): loaded http://localhost:51535/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51535/tests/dromaeo/cssquery-mootools.html) 04:21:52 INFO - PROCESS | 24242 | RSS: Main: 151195648 04:21:52 INFO - PROCESS | 24242 | 04:24:53 INFO - PROCESS | 24242 | Cycle 1(1): loaded http://localhost:51535/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51535/tests/dromaeo/cssquery-prototype.html) 04:24:54 INFO - PROCESS | 24242 | RSS: Main: 150753280 04:24:54 INFO - PROCESS | 24242 | 04:27:57 INFO - PROCESS | 24242 | Cycle 1(1): loaded http://localhost:51535/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51535/tests/dromaeo/cssquery-yui.html) 04:27:57 INFO - PROCESS | 24242 | RSS: Main: 151547904 04:27:57 INFO - PROCESS | 24242 | 04:31:00 INFO - PROCESS | 24242 | Cycle 1(1): loaded http://localhost:51535/tests/dromaeo/cssquery-yui.html (next: http://localhost:51535/tests/dromaeo/cssquery-dojo.html) 04:31:00 INFO - PROCESS | 24242 | RSS: Main: 153714688 04:31:00 INFO - PROCESS | 24242 | 04:31:00 INFO - PROCESS | 24242 | __start_tp_report 04:31:00 INFO - PROCESS | 24242 | _x_x_mozilla_page_load 04:31:00 INFO - PROCESS | 24242 | _x_x_mozilla_page_load_details 04:31:00 INFO - PROCESS | 24242 | |i|pagename|runs| 04:31:00 INFO - PROCESS | 24242 | |0;dojo.html;2654.8938042478303;2668.2262143978246;2742.657167854017;2743.0536464919596;2757.159066484722;4492.865214043584;4566.429196350452;4598.954010459895;4610.17016936952;4622.884427889305;4507.3689683444345;4539.477960034597;4556.84051058213;4597.88505287368;4625.190591646465;4198.6431153352005;4206.179794939988;4250.681198910079;4266.637335826458;4299.462567179103;4271.145770845827;4324.286492728712;4326.524082350938;4348.739075655455;4363.585459381354;4020.2562525932503;4164.416981622575;4185.895352616179;4297.333913243452;4301.591348821873;4237.0890258594245;4244.660427165819;4248.490181178247;4266.935995960032;4281.357796330544;4212.7682977436225;4221.514525829538;4242.236397448458;4277.165952639237;4280.935785963213;4431.09162621665;4498.347739577743;4501.504834468205;4521.299198624219;4593.56361145694;4889.706617602955;4898.289747986522;4903.705777653352;4909.386326709161;4925.876853078666;4932.926006109911;4934;4935.062338155739;4938.333325001115;4981.750912454399;4516.932246016312;4558.247889098328;4601.6548758842555;4610.446746390455;4636;5021.171506701427;5029.899402011939;5032.6225533084435;5039.672421292605;5097.6941383517105;4851.684640498356;4852.369192005017;4852.56326930578;4861.586765124934;4901.166801643729;4763.04739052191;4841.806327746921;4910.729909854992;4939.259111133359;5001.89996200074;4816.494268101869;4830;4834.178189707758;4841.709497430165;4881.9023619528125;4689.812407503729;4783.1390349737385;4791.808327666854;4798.95201047985;4836.226203807374;4013.418054382098;4068.4507591475362;4113.8971525711495;4115.97942010288;4144.274751918462;3607.7474576779373;3636.399994001013;3644.599094099647;3655.2689462107155;3670.100825297819;4169.937450938239;4244.087521182961;4272.401863739079;4274.978625106854;4289.335153051282;4882.731449770296;4901.215805471179;4903.166461701519;4905.994271174401;4952.2819191217795;4238.957610423918;4251.4685664291965;4261.232978063978;4271.402003719481;4298.613124818781;4194.916101678011;4287.721298115613;4296.398504209351;4352.194843953878;4383.320585309219;4705.929411058768;4709.505501922317;4712.340272361941;4724.173269677793;4725.10223057618;4906.607471402351;4938.506149385033;4956.975215123901;4975.228839529878;4995.800167993385;4490.371348011216;4575.496695363574;4667.953320466888;4683.555062269079;4748.05038992196;4824.6863953842885;4834.20235661112;4838.467768545387;4848.224284114524;4850.708957462563;4874.0495603357;4879.682820616648;4895.388076490439;4912.606991440748;4950.752462376939;4672.906541869075;4729.314249433882;4746.027064451848;4768.737719425465;4805.5915247204375;4678.157931572349;4701.482836888008;4703.764811759467;4747;4761.928571071506;4499.617532509773;4604.907901842012;4618.237990731492;4628.305754136772;4643.791029403617;4758.571728544448;4780.163471392423;4837.612990960644;4842.104210721028;4887.511248875084;4594.816207351669;4599;4604.033153037765;4641.512641172628;4648.2330415481065 04:31:00 INFO - PROCESS | 24242 | |1;ext.html;501.12803721524534;510.9897802043959;528.3685995235693;536.4153073150266;593.0007936626787;32349.118105827303;33012.504812427775;33050.504242436386;33075.33849323012;33223.33553328932;32460.837695811548;32531.837340813323;33087;33127.83436082822;33155.33689326218;7383.224761400043;7637.701590729589;7660.2722741339485;7665.846683066336;7676.385889128885;7538.359239464652;7634.885476717854;7644.579548124851;7666.348360389374;7671.923280767204;7643.082830060401;7690.961545192266;7698.384129269673;7703.191164927686;7729.61351932404;7605.467617266793;7701.768946931601;7706.190849960757;7715.845683086363;7726.690932362699;7545.245475452466;7634.351080158138;7677.30904218623;7685.884711729329;7691.23087691232;33280.500792488136;33610.1597460063;33759.493607595905;33769.49345759815;33881.83059084714;3023.470892593787;3130.624325080982;3131.5459258407404;3260.4294248506417;3416;27545;27988;28183.295417614518;28291;28472.715272847214;3368.6986752982216;3407.165244515085;3421.674940880612;3443.984024712691;3503.0016445312963;210908;212220;212357;212401;212510;51944;52126.478735212164;52176.21735673968;52180;52192.47807521952;47831;48815.51184488181;56443.43556564464;57476;57512.424875751545;14269.500567480089;14296;14437.783433248509;14461.710765784836;14482.637934051521;11124.61063862761;11134.053605443465;11165.553377864795;11177.329360238411;11231;17309.65380692404;17531.474055778348;17614.647707045788;17625.383111591033;17685.469435916944;7226.891596626055;7414.480986330905;7469.477136600494;7479.401647868158;7487.588182649898;869.6564856881496;891.3225948279354;897.6185121323412;905.0316161707042;997.9970130019284;25035.248942531754;25328.493430131664;25562.616560751605;25572.744272557407;26024.219273421448;962.629387685746;963.426761077158;991.7768502086973;1001.7746007148334;1081.8160912644869;11722.88277117235;11787.646370608896;11819.399732058933;11909.404529773477;11936.403179841147;252068;254626;255336;255504;255512;43081;43236.3514547282;43299.567004329554;43305.56694433015;43720.562794371646;1220.4934951995;1225.3934302520308;1232.7596118756935;1239.8388209532702;1249.4814651919532;21737.456563586038;22382.88808555947;22750.544989100457;22920.541589168457;23243.76756232416;34415;34578.308433831684;34605;34845.12887177841;35309.117272068404;242781;243250;243973;244329;245009;26973.325666858487;28214.71785282121;28806;28811;28865.7113428863;31068.68931310658;31332.37335253328;31472.213194670316;32000.35999279955;32028.03915882527;27801.44397112006;27860.860695696392;27986;28126.718732813228;28142.15573532797;27564.448711026067;27705.168844934684;27790.722092778815;27967.58048629313;28216.85891570529;31377;31386.372272554876;31446.371072578877;31792.04623861288;31875.6812431882;25757.613635795104;26821.597676035264;28320;28641;28723.712762872103;21998.34004979853;22388.88805555962;22793.430164246027;22859.428514287276;22953.770462295164 04:31:00 INFO - PROCESS | 24242 | |2;jquery.html;350.2871656179675;350.8859620623298;351.1011809766995;352.2110472541507;354.71445486383453;13773.51792687256;14220.644483887909;15191.240437978113;15753.684926301496;16119.919400402996;14290.714185716279;14385.280735963212;15353.923230383833;15410.768838467431;15460.226988650578;4376.6279866211335;4424.3142312941545;4585.839495617654;4587.243104887706;4600.1259760645535;4481.551844815525;4559.680822342438;4584.037352156051;4584.381108550353;4584.931226031612;4587.931181032271;4611.446626404836;4777.713337199762;4809.422869255677;4810.97594512027;4744.240921452551;4860.708357498544;4896.46138924718;5287.47125287472;5293.073712100367;5080.13637681595;5114.744262786846;5118.872028199287;5121.027004869063;5123.641345105844;13009.479620815251;17605.911970440065;17995.460136195936;18160.90919545407;18290.542736431697;1829.7438358629802;1867.2624313396132;1909.312647446918;1922.298361098203;1926.6050459655878;8183.754487365389;8626.78433039179;9389.906100938972;9889.901100989042;12093.697657558543;1725.8791884568086;1796.7215081662364;1908.3702378215155;1967.911443985024;2002.3692536850845;40251;41794.79102604467;41916.580834191576;41948.16103677909;42488.78755606233;9368.765780855532;9413.623455061857;9434.764130896783;9456.196223321094;9497.192738617296;11452.885471145182;11699.824502632468;11761;11873.940630296793;11874.821877671842;6892.655367231619;7127.572345659277;7212.639368031578;7224.060872086595;7270.781876543712;6972.163340399185;7065.717371305193;7070.8939365909555;7087.184973728087;7170.784876453715;4122.134351786099;4191.559886211965;4215.515215750167;4246.723962942398;4260.765657888784;1801.3335066025393;1823.7993820679715;1836.3205613922935;1848.7966323704381;1885.7359969604267;828.225609055535;863.5078005536784;867.6919693508839;886.1670030171618;941.3786900645541;14754.188519631309;14769.33537990793;14992.325345359484;15256.38974441032;15386.769198462032;829.5810615639064;849.5072857742495;852.2500199824239;856.2037305306125;892.1836519584507;8557;8917.464952102764;8988.955055224813;9120.361574689841;9236.307276954121;297620;302555;303352;303406;454504;39204.60795392067;45432.772836135606;52559.47440525546;55344.72327638336;56835.43164568384;1066.4507778494083;1087.8857719939451;1089.3518356577824;1089.5750657243682;1095.4030053620795;12765.48938042505;12841.871581284442;13765;13887.58337249884;13938.024338296222;26732.866335668197;27557.586636200875;27863.16410507688;29785.85107074451;31131.844340778152;35118.47322290219;36115;36775.632243678294;36990.630093699794;37363.813180933925;3155.684431556918;3531.6579699713943;6098.329183789869;6485.967570162307;6518.706658200487;8483.490990540588;9430.858537122085;9462.952685236529;9551.952240238754;9552.331336806636;7869.291763741291;8353.916460835313;8403.915960840313;8475.364347673825;8486.575671216291;8507.064222935349;8611.6985905493;8647.264982476308;8731.607077681647;8902.688405905763;8565.400421970402;9072.50101244438;9170.174684278447;9294.674686386215;9437.811243775224;6160.10678451631;6833.077534532775;6852.383285504328;6876;6882.483813713891;8143.714969976022;8323.458975166595;8395.202455766692;8520.19058189471;8524 04:31:00 INFO - PROCESS | 24242 | |3;mootools.html;1390.8609139086088;1391.0888368118883;1527.3737767515322;1718.9570260743471;1736.5919009032882;6235.875282494348;6358.936410635893;7207.17117531484;7357.558546487207;7371.115466144063;6853.588784672923;6856.862862742742;6940.6876690548925;6957.443404527638;6971.128608923885;2134.530403311273;2151.1180416029433;2167.7832216778274;2168.1327469012363;2171.7393912730417;2137.059693734752;2154.6013987412302;2183.967240491386;2185.8579192352527;2186.0053675577656;2186.212963333199;2202.0861342542826;2202.746684131321;2203.2398822406326;2206.735191776989;2185.4317877351923;2193.144673577306;2195.736511618608;2196.4399078234947;2197.56048790241;2106.9789302106938;2137.5404288077984;2138.5081431270896;2139.1015773375066;2145.2706079932896;7291.307325804093;7321.560706357635;7369.710300697357;7373.152087509898;7392.112946446461;4287.871363859089;4355.303151495746;4374.147041326943;4380.189664912002;4388.71473354231;2691.3944362518473;2693.9730602693917;2790.330320723032;2790.9023184188454;2794.636697229347;820.7168526858225;835.4486039214089;862.9741107766777;871.372611719561;874.2394117118148;9830.754231144207;9839.852402213972;9896.802063958752;9928.007199280015;9934.304598678096;4016.8393264269685;4032.334664780337;4102.979485102555;4136;4142.958570414317;8573.528455934858;8600.311975041981;8606.741797746077;8607.26838218746;8607.655693772303;4375.671824613103;4376.431063961664;4389.780510974439;4412;4432.889177770517;3453.689167974894;3534.929301413957;3852.3836186210074;3965.920681586352;3976.343903255988;3469.358168738741;3469.6877281044826;3508.5965114011706;3513.80674062929;3530.4880792284976;1127.1546340244815;1137.5506674863382;1163.3543383422113;1164.3537836500655;1166.562539047857;1037.527924794217;1041.2763129624839;1051.7055224537141;1069.1553672598716;1080.9729756756144;6559.147310849559;6590.868182636321;6591.769288074895;6597.30728273534;6621.503387245976;432.6992740045638;1080.6595922284455;1139.3050239353988;1148.311013391975;1159.4202898550725;4795.976020119877;4880.243562247857;4894;4894.706317620954;4898.21628539432;8369.455985360932;8386.706465273686;8531.146885311418;8573.657053717781;8609.69866054685;8356.540390278471;8377.83244335122;8392;8423.284020858173;8488.278496327881;6829.658517074126;6902.344277293649;6904.4131248844415;6917.342852429011;6934.16789985205;6192.59748116371;6271.560990730605;6314.55798094129;6319.96840015797;6323.336049714714;7605.543667379975;7608.391328693802;7735.265149810984;7746.767596972099;7808.84382312362;7786.26030527099;7832.725854595062;7954.363650908029;8011.679532818622;8017.398695098008;5709.429057094423;5831.650100993954;6457.128287681103;6599.835004124935;6715.127033485615;6442.420182183439;6471.320511346241;6474.741010359533;6483.027545868157;6499.1876015498065;6102.816915492543;6206.382344169437;6319.146915166394;6580.078788969452;6593.109930159367;6151.3541078186145;6187.535934804998;6315.55791094619;6328.335524770017;6341.0805433212845;6402.231732192166;6459.257185423737;6460.515461340512;6478.514111441755;6482.384173503509;6097.024476083805;6180.072989051499;6190.102435146789;6214.658193799203;6219.253689557282;6101.725422355916;6105.358937311518;6157.6613286269685;6160.229971253593;6161.661108639068 04:31:00 INFO - PROCESS | 24242 | |4;prototype.html;317.90303957293025;328.382640635605;330.30141251253605;335.163766402825;336.436468914568;5487.670739755617;5503.972480137599;5529.972350138254;5591.38494765576;5685.033544297469;5467.316585426822;5510.173473978905;5529.30883639545;5540.584456165783;5547.11246200608;4304.397384366192;4310.4611923509565;4311.611954924057;4311.633511151548;4315.158544083889;4307.741535507864;4313.482382114151;4315.956840431587;4316.525182229952;4322.740635561876;4175.290200665894;4258.7870606469705;4274.4229529013655;4279.593438623326;4281.122369914176;4188.62302392783;4258.127083947783;4269.167512335081;4272.9145417091795;4282.207791558571;3706.814659267026;3707.3326801175776;3710.406334986389;3714.275716235335;3715.1269451678836;5331.1470164773455;5344.064788662007;5348.358197016383;5355.3305836770405;5360.624756267063;4899.069176856386;4902.558769710743;4912.115819152551;4919.26211068339;4926.137925862996;5580.86047848803;5732.283464566929;5802.738876750556;5809.6804675742815;5831.358550559435;4010.9598904010877;4016.6385025347568;4017.6183262590007;4020.4170395292517;4021.4973128358956;6003.879922401571;6083.847903802441;6088.8782224356155;6093.451589356935;6109.786157484511;4024.476818013698;4143.917121657611;4144.647704945053;4148.2947898857265;4161.604647558477;4192;4193.098483825992;4195.098053918422;4197.622214000755;4204.285271503852;4804.327394164819;4814.855554333376;4840.588549973221;4868.488808675109;4881.560659540658;5779.393163717833;5787.363390027093;5795.159701843293;5820.24336836217;5852.736626851802;1404.6909679870616;1483.7032593481347;1485.049568276304;1508.1328236264192;1511.6372070702953;953.0707560128819;1008.0625018732649;1009.5204777730519;1018.5263852308713;1022.2077889635592;4933.186024305949;5003.949960500421;5009.323741294951;5011;5034.572061374824;5876.676782776988;5970.34326224115;5992.940070599326;5994.640321580632;6000.21997140369;4994.300797888299;5009.298698182258;5010.749462526859;5026.170681837529;5039.69761814285;3203.5515027896113;3229.7254733347927;3235.1588586967086;3244.6430892601793;3245.8214798186327;5461.42655021225;5610.551155907518;5612.1581762735095;5614.9438505615235;5619.522340601095;6148.569600128038;6187.690615469209;6207.751689932443;6212.285587157535;6217.191765070512;5592.5246354059545;5604.103343465107;5605.943940560543;5606.60753747242;5617.101263797855;5979.312379076462;5980.491658208927;5980.611260268069;5984.162217289496;5992.730327135377;5747.568932330176;5813.215215945793;5895.587308888336;5914.970425147847;5990.880182396415;5678.801241956677;5689;5712.65724056558;5726.398728133652;5728.684922329312;4252.298370768788;4277.593628605277;4328.783560822009;4337.609615134653;4341.066670665822;5899.793507227399;6024.518038556817;6027.186329845415;6035.456808887221;6040.697965101639;5785.710714464344;5788.9131663024245;5797.594168408171;5800.912986305125;5807.94192058074;5712.42875712442;5790.652560846363;5825.563082768725;5855.151003104611;5890.322612899571;5678.829635110953;5682.971585142048;5699.230603868425;5701.059325211294;5738.053221218453;5849.210356601804;5849.795257165979;5863.120531920246;5870.207521984477;5892.145638882424;5576.302962129734;5643.294588176478;5687.1753595729215;5689.857753556194;5690.857728556819 04:31:00 INFO - PROCESS | 24242 | |5;yui.html;668.4451904918918;682.6382017530708;708.5713143548156;736.2747693521883;757.923748277446;11282.774344513115;11471.19701620887;11488.425578721062;11500.539978400875;11532.192746507759;10895.400752958603;11823.408829558532;11831;11838.585649502247;11859.288442693445;768.7578412799978;770.6647608290411;783.4085265624445;788.7239466186846;791.3115589437198;777.708359365238;779.7426849139798;784.1335324466439;785.2069409895989;788.4756636836526;814.1207495904439;815.3151352863594;816.4529765057396;816.6243527977138;818.3698552114868;798;798.9280964713146;803.586153131138;804.891339669143;810.5096416667919;599.6102533353355;603.0803025386277;603.616703393344;604.4016423740509;605.403677377787;12291.877081229162;12297.077719171008;12383.257004579664;12473.251604903644;12781.488740450372;10494.527746251437;11152.721181970515;11550;12002.69993250167;12122.454489547992;9612.375195612263;9702.75743106428;9748.512574371323;9784.11942925133;9885.456299903502;3273.558069660613;3281.1305004173914;3311.4536101543217;3348.866045358207;3423.845926933294;40462;40696.982575435555;40872;40956.38565421521;40957.59042409567;9153.77115572116;9232.53837308132;9380.90619093814;9431;9493.762655933519;15717.685646287011;15744;15746.212689365486;15816.209189540707;15923.601909952113;6303.36966303366;6447.6453795041725;6471.967640161769;6501;6587.440067594308;3858.112634094174;3881.9611803882162;3889.902752431212;3914.7455415398476;3933.9016524587114;2559.3345730110304;2586.1465716313573;2624.9868750656124;2629.881655325515;2640.2475294541346;507.6294305157182;508.1057339083166;509.67380876238497;515.0960065085751;516.7803683434526;477.0435277269053;505.219435971425;509.24685071026033;531.8510816971177;546.9863253418616;6715.46276297895;6793.898091528631;6845.236615951994;6963.1644202696;6986.545874518241;468.981240750373;477.9044191161712;494.81691774043117;599.2389665125266;615.547572534187;3455.6371580984137;3501.509788629594;3645.198056427582;3684.963150368462;3694.9445758313645;44453.55546444559;44692.3296150558;44803.55196448059;44838.775806120764;45155;41237.96905077397;41357.379639305436;41720;42090.316387344166;42343.57656423396;36271.81864090716;36292.27415451676;37498.25003499969;38397.808010959765;38489.42265866014;7244.855102897807;7262.273772622695;7289.817754556178;7297.306755858397;7528.8494230116185;28256.434871302048;28695.13914582566;28923;29246.26884327909;29492.115236542937;35794.284114317044;35829.64170358263;35981;36050.63949360578;36991.260174796895;9700.5149742514;9800.215982721222;9911.900880991097;9971.900280997097;10002.899971000197;10650.201234907257;10659.413732244491;11050.33697978124;11052.171087168334;11259.155563332619;10240.334378265388;10312.175025997753;10385.948070259903;10522.421266830092;10632.239791364495;9926.751831204278;9950.35322704022;10272.948635256776;10338.379697218192;10427.94786026065;10254.948725256327;10277.794444110927;10500.054995050483;10563.577456901638;10599.62901298451;8953.194212520904;9178.724638260863;9247.445153290824;9252.676156334495;9313.720588382359;8951.239144672516;9113.225375842863;9201.677941272023;9271.851396625756;9565.378250413702 04:31:00 INFO - PROCESS | 24242 | __end_tp_report 04:31:00 INFO - PROCESS | 24242 | __start_cc_report 04:31:00 INFO - PROCESS | 24242 | _x_x_mozilla_cycle_collect,348 04:31:00 INFO - PROCESS | 24242 | __end_cc_report 04:31:00 INFO - PROCESS | 24242 | __startTimestamp1452861060362__endTimestamp 04:31:00 INFO - PROCESS | 24242 | 04:31:00 INFO - PROCESS | 24242 | ------- Summary: start ------- 04:31:00 INFO - PROCESS | 24242 | Number of tests: 6 04:31:00 INFO - PROCESS | 24242 | 04:31:00 INFO - PROCESS | 24242 | [#0] dojo.html Cycles:165 Average:4530.14 Median:4628.31 stddev:452.05 (9.8%) stddev-sans-first:428.83 04:31:00 INFO - PROCESS | 24242 | Values: 2654.9 2668.2 2742.7 2743.1 2757.2 4492.9 4566.4 4599.0 4610.2 4622.9 4507.4 4539.5 4556.8 4597.9 4625.2 4198.6 4206.2 4250.7 4266.6 4299.5 4271.1 4324.3 4326.5 4348.7 4363.6 4020.3 4164.4 4185.9 4297.3 4301.6 4237.1 4244.7 4248.5 4266.9 4281.4 4212.8 4221.5 4242.2 4277.2 4280.9 4431.1 4498.3 4501.5 4521.3 4593.6 4889.7 4898.3 4903.7 4909.4 4925.9 4932.9 4934.0 4935.1 4938.3 4981.8 4516.9 4558.2 4601.7 4610.4 4636.0 5021.2 5029.9 5032.6 5039.7 5097.7 4851.7 4852.4 4852.6 4861.6 4901.2 4763.0 4841.8 4910.7 4939.3 5001.9 4816.5 4830.0 4834.2 4841.7 4881.9 4689.8 4783.1 4791.8 4799.0 4836.2 4013.4 4068.5 4113.9 4116.0 4144.3 3607.7 3636.4 3644.6 3655.3 3670.1 4169.9 4244.1 4272.4 4275.0 4289.3 4882.7 4901.2 4903.2 4906.0 4952.3 4239.0 4251.5 4261.2 4271.4 4298.6 4194.9 4287.7 4296.4 4352.2 4383.3 4705.9 4709.5 4712.3 4724.2 4725.1 4906.6 4938.5 4957.0 4975.2 4995.8 4490.4 4575.5 4668.0 4683.6 4748.1 4824.7 4834.2 4838.5 4848.2 4850.7 4874.0 4879.7 4895.4 4912.6 4950.8 4672.9 4729.3 4746.0 4768.7 4805.6 4678.2 4701.5 4703.8 4747.0 4761.9 4499.6 4604.9 4618.2 4628.3 4643.8 4758.6 4780.2 4837.6 4842.1 4887.5 4594.8 4599.0 4604.0 4641.5 4648.2 04:31:00 INFO - PROCESS | 24242 | 04:31:00 INFO - PROCESS | 24242 | [#1] ext.html Cycles:180 Average:38293.35 Median:31632.13 stddev:61911.18 (195.7%) stddev-sans-first:62019.83 04:31:00 INFO - PROCESS | 24242 | Values: 501.1 511.0 528.4 536.4 593.0 32349.1 33012.5 33050.5 33075.3 33223.3 32460.8 32531.8 33087.0 33127.8 33155.3 7383.2 7637.7 7660.3 7665.8 7676.4 7538.4 7634.9 7644.6 7666.3 7671.9 7643.1 7691.0 7698.4 7703.2 7729.6 7605.5 7701.8 7706.2 7715.8 7726.7 7545.2 7634.4 7677.3 7685.9 7691.2 33280.5 33610.2 33759.5 33769.5 33881.8 3023.5 3130.6 3131.5 3260.4 3416.0 27545.0 27988.0 28183.3 28291.0 28472.7 3368.7 3407.2 3421.7 3444.0 3503.0 210908.0 212220.0 212357.0 212401.0 212510.0 51944.0 52126.5 52176.2 52180.0 52192.5 47831.0 48815.5 56443.4 57476.0 57512.4 14269.5 14296.0 14437.8 14461.7 14482.6 11124.6 11134.1 11165.6 11177.3 11231.0 17309.7 17531.5 17614.6 17625.4 17685.5 7226.9 7414.5 7469.5 7479.4 7487.6 869.7 891.3 897.6 905.0 998.0 25035.2 25328.5 25562.6 25572.7 26024.2 962.6 963.4 991.8 1001.8 1081.8 11722.9 11787.6 11819.4 11909.4 11936.4 252068.0 254626.0 255336.0 255504.0 255512.0 43081.0 43236.4 43299.6 43305.6 43720.6 1220.5 1225.4 1232.8 1239.8 1249.5 21737.5 22382.9 22750.5 22920.5 23243.8 34415.0 34578.3 34605.0 34845.1 35309.1 242781.0 243250.0 243973.0 244329.0 245009.0 26973.3 28214.7 28806.0 28811.0 28865.7 31068.7 31332.4 31472.2 32000.4 32028.0 27801.4 27860.9 27986.0 28126.7 28142.2 27564.4 27705.2 27790.7 27967.6 28216.9 31377.0 31386.4 31446.4 31792.0 31875.7 25757.6 26821.6 28320.0 28641.0 28723.7 21998.3 22388.9 22793.4 22859.4 22953.8 04:31:00 INFO - PROCESS | 24242 | 04:31:00 INFO - PROCESS | 24242 | [#2] jquery.html Cycles:180 Average:19749.01 Median:4584.66 stddev:55126.28 (1202.4%) stddev-sans-first:55261.69 04:31:00 INFO - PROCESS | 24242 | Values: 350.3 350.9 351.1 352.2 354.7 13773.5 14220.6 15191.2 15753.7 16119.9 14290.7 14385.3 15353.9 15410.8 15460.2 4376.6 4424.3 4585.8 4587.2 4600.1 4481.6 4559.7 4584.0 4584.4 4584.9 4587.9 4611.4 4777.7 4809.4 4811.0 4744.2 4860.7 4896.5 5287.5 5293.1 5080.1 5114.7 5118.9 5121.0 5123.6 13009.5 17605.9 17995.5 18160.9 18290.5 1829.7 1867.3 1909.3 1922.3 1926.6 8183.8 8626.8 9389.9 9889.9 12093.7 1725.9 1796.7 1908.4 1967.9 2002.4 40251.0 41794.8 41916.6 41948.2 42488.8 9368.8 9413.6 9434.8 9456.2 9497.2 11452.9 11699.8 11761.0 11873.9 11874.8 6892.7 7127.6 7212.6 7224.1 7270.8 6972.2 7065.7 7070.9 7087.2 7170.8 4122.1 4191.6 4215.5 4246.7 4260.8 1801.3 1823.8 1836.3 1848.8 1885.7 828.2 863.5 867.7 886.2 941.4 14754.2 14769.3 14992.3 15256.4 15386.8 829.6 849.5 852.3 856.2 892.2 8557.0 8917.5 8989.0 9120.4 9236.3 297620.0 302555.0 303352.0 303406.0 454504.0 39204.6 45432.8 52559.5 55344.7 56835.4 1066.5 1087.9 1089.4 1089.6 1095.4 12765.5 12841.9 13765.0 13887.6 13938.0 26732.9 27557.6 27863.2 29785.9 31131.8 35118.5 36115.0 36775.6 36990.6 37363.8 3155.7 3531.7 6098.3 6486.0 6518.7 8483.5 9430.9 9463.0 9552.0 9552.3 7869.3 8353.9 8403.9 8475.4 8486.6 8507.1 8611.7 8647.3 8731.6 8902.7 8565.4 9072.5 9170.2 9294.7 9437.8 6160.1 6833.1 6852.4 6876.0 6882.5 8143.7 8323.5 8395.2 8520.2 8524.0 04:31:00 INFO - PROCESS | 24242 | 04:31:00 INFO - PROCESS | 24242 | [#3] mootools.html Cycles:180 Average:5007.56 Median:6183.80 stddev:2566.31 (41.5%) stddev-sans-first:2559.11 04:31:00 INFO - PROCESS | 24242 | Values: 1390.9 1391.1 1527.4 1719.0 1736.6 6235.9 6358.9 7207.2 7357.6 7371.1 6853.6 6856.9 6940.7 6957.4 6971.1 2134.5 2151.1 2167.8 2168.1 2171.7 2137.1 2154.6 2184.0 2185.9 2186.0 2186.2 2202.1 2202.7 2203.2 2206.7 2185.4 2193.1 2195.7 2196.4 2197.6 2107.0 2137.5 2138.5 2139.1 2145.3 7291.3 7321.6 7369.7 7373.2 7392.1 4287.9 4355.3 4374.1 4380.2 4388.7 2691.4 2694.0 2790.3 2790.9 2794.6 820.7 835.4 863.0 871.4 874.2 9830.8 9839.9 9896.8 9928.0 9934.3 4016.8 4032.3 4103.0 4136.0 4143.0 8573.5 8600.3 8606.7 8607.3 8607.7 4375.7 4376.4 4389.8 4412.0 4432.9 3453.7 3534.9 3852.4 3965.9 3976.3 3469.4 3469.7 3508.6 3513.8 3530.5 1127.2 1137.6 1163.4 1164.4 1166.6 1037.5 1041.3 1051.7 1069.2 1081.0 6559.1 6590.9 6591.8 6597.3 6621.5 432.7 1080.7 1139.3 1148.3 1159.4 4796.0 4880.2 4894.0 4894.7 4898.2 8369.5 8386.7 8531.1 8573.7 8609.7 8356.5 8377.8 8392.0 8423.3 8488.3 6829.7 6902.3 6904.4 6917.3 6934.2 6192.6 6271.6 6314.6 6320.0 6323.3 7605.5 7608.4 7735.3 7746.8 7808.8 7786.3 7832.7 7954.4 8011.7 8017.4 5709.4 5831.7 6457.1 6599.8 6715.1 6442.4 6471.3 6474.7 6483.0 6499.2 6102.8 6206.4 6319.1 6580.1 6593.1 6151.4 6187.5 6315.6 6328.3 6341.1 6402.2 6459.3 6460.5 6478.5 6482.4 6097.0 6180.1 6190.1 6214.7 6219.3 6101.7 6105.4 6157.7 6160.2 6161.7 04:31:00 INFO - PROCESS | 24242 | 04:31:00 INFO - PROCESS | 24242 | [#4] prototype.html Cycles:180 Average:4808.74 Median:5477.49 stddev:1408.46 (25.7%) stddev-sans-first:1371.48 04:31:00 INFO - PROCESS | 24242 | Values: 317.9 328.4 330.3 335.2 336.4 5487.7 5504.0 5530.0 5591.4 5685.0 5467.3 5510.2 5529.3 5540.6 5547.1 4304.4 4310.5 4311.6 4311.6 4315.2 4307.7 4313.5 4316.0 4316.5 4322.7 4175.3 4258.8 4274.4 4279.6 4281.1 4188.6 4258.1 4269.2 4272.9 4282.2 3706.8 3707.3 3710.4 3714.3 3715.1 5331.1 5344.1 5348.4 5355.3 5360.6 4899.1 4902.6 4912.1 4919.3 4926.1 5580.9 5732.3 5802.7 5809.7 5831.4 4011.0 4016.6 4017.6 4020.4 4021.5 6003.9 6083.8 6088.9 6093.5 6109.8 4024.5 4143.9 4144.6 4148.3 4161.6 4192.0 4193.1 4195.1 4197.6 4204.3 4804.3 4814.9 4840.6 4868.5 4881.6 5779.4 5787.4 5795.2 5820.2 5852.7 1404.7 1483.7 1485.0 1508.1 1511.6 953.1 1008.1 1009.5 1018.5 1022.2 4933.2 5003.9 5009.3 5011.0 5034.6 5876.7 5970.3 5992.9 5994.6 6000.2 4994.3 5009.3 5010.7 5026.2 5039.7 3203.6 3229.7 3235.2 3244.6 3245.8 5461.4 5610.6 5612.2 5614.9 5619.5 6148.6 6187.7 6207.8 6212.3 6217.2 5592.5 5604.1 5605.9 5606.6 5617.1 5979.3 5980.5 5980.6 5984.2 5992.7 5747.6 5813.2 5895.6 5915.0 5990.9 5678.8 5689.0 5712.7 5726.4 5728.7 4252.3 4277.6 4328.8 4337.6 4341.1 5899.8 6024.5 6027.2 6035.5 6040.7 5785.7 5788.9 5797.6 5800.9 5807.9 5712.4 5790.7 5825.6 5855.2 5890.3 5678.8 5683.0 5699.2 5701.1 5738.1 5849.2 5849.8 5863.1 5870.2 5892.1 5576.3 5643.3 5687.2 5689.9 5690.9 04:31:00 INFO - PROCESS | 24242 | 04:31:00 INFO - PROCESS | 24242 | [#5] yui.html Cycles:180 Average:11723.63 Median:44747.94 stddev:12829.31 (28.7%) stddev-sans-first:12838.43 04:31:00 INFO - PROCESS | 24242 | Values: 668.4 682.6 708.6 736.3 757.9 11282.8 11471.2 11488.4 11500.5 11532.2 10895.4 11823.4 11831.0 11838.6 11859.3 768.8 770.7 783.4 788.7 791.3 777.7 779.7 784.1 785.2 788.5 814.1 815.3 816.5 816.6 818.4 798.0 798.9 803.6 804.9 810.5 599.6 603.1 603.6 604.4 605.4 12291.9 12297.1 12383.3 12473.3 12781.5 10494.5 11152.7 11550.0 12002.7 12122.5 9612.4 9702.8 9748.5 9784.1 9885.5 3273.6 3281.1 3311.5 3348.9 3423.8 40462.0 40697.0 40872.0 40956.4 40957.6 9153.8 9232.5 9380.9 9431.0 9493.8 15717.7 15744.0 15746.2 15816.2 15923.6 6303.4 6447.6 6472.0 6501.0 6587.4 3858.1 3882.0 3889.9 3914.7 3933.9 2559.3 2586.1 2625.0 2629.9 2640.2 507.6 508.1 509.7 515.1 516.8 477.0 505.2 509.2 531.9 547.0 6715.5 6793.9 6845.2 6963.2 6986.5 469.0 477.9 494.8 599.2 615.5 3455.6 3501.5 3645.2 3685.0 3694.9 44453.6 44692.3 44803.6 44838.8 45155.0 41238.0 41357.4 41720.0 42090.3 42343.6 36271.8 36292.3 37498.3 38397.8 38489.4 7244.9 7262.3 7289.8 7297.3 7528.8 28256.4 28695.1 28923.0 29246.3 29492.1 35794.3 35829.6 35981.0 36050.6 36991.3 9700.5 9800.2 9911.9 9971.9 10002.9 10650.2 10659.4 11050.3 11052.2 11259.2 10240.3 10312.2 10385.9 10522.4 10632.2 9926.8 9950.4 10272.9 10338.4 10427.9 10254.9 10277.8 10500.1 10563.6 10599.6 8953.2 9178.7 9247.4 9252.7 9313.7 8951.2 9113.2 9201.7 9271.9 9565.4 04:31:00 INFO - PROCESS | 24242 | -------- Summary: end -------- 04:31:00 INFO - PROCESS | 24242 | 04:31:01 INFO - TEST-INFO | 24242: exit 0 04:31:01 INFO - TEST-OK | dromaeo_css | took 1113520ms 04:31:01 INFO - TEST-START | kraken 04:31:01 INFO - operating with platform_type : linux_ 04:31:01 INFO - Initialising browser for kraken test... 04:31:01 INFO - TEST-INFO | started process 24482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqF_smz/profile http://localhost:51535/getInfo.html) 04:31:04 INFO - PROCESS | 24482 | 04:31:04 INFO - PROCESS | 24482 | (process:24555): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:31:05 INFO - PROCESS | 24482 | __metrics Screen width/height:1600/1200 04:31:05 INFO - PROCESS | 24482 | colorDepth:24 04:31:05 INFO - PROCESS | 24482 | Browser inner width/height: 1024/697 04:31:05 INFO - PROCESS | 24482 | __metrics 04:31:05 INFO - PROCESS | 24482 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:31:06 INFO - TEST-INFO | 24482: exit 0 04:31:06 INFO - Browser initialized. 04:31:06 INFO - Running cycle 1/1 for kraken test... 04:31:06 INFO - TEST-INFO | started process 24604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqF_smz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:07 INFO - PROCESS | 24604 | 04:31:07 INFO - PROCESS | 24604 | (process:24660): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:31:18 INFO - PROCESS | 24604 | RSS: Main: 150360064 04:31:18 INFO - PROCESS | 24604 | 04:31:20 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51535/tests/kraken/driver.html?testName=audio-beat-detection) 04:31:21 INFO - PROCESS | 24604 | RSS: Main: 150134784 04:31:21 INFO - PROCESS | 24604 | 04:31:24 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51535/tests/kraken/driver.html?testName=audio-dft) 04:31:24 INFO - PROCESS | 24604 | RSS: Main: 154021888 04:31:24 INFO - PROCESS | 24604 | 04:31:27 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51535/tests/kraken/driver.html?testName=audio-fft) 04:31:28 INFO - PROCESS | 24604 | RSS: Main: 149254144 04:31:28 INFO - PROCESS | 24604 | 04:31:30 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51535/tests/kraken/driver.html?testName=audio-oscillator) 04:31:31 INFO - PROCESS | 24604 | RSS: Main: 149221376 04:31:31 INFO - PROCESS | 24604 | 04:31:33 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51535/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:34 INFO - PROCESS | 24604 | RSS: Main: 150011904 04:31:34 INFO - PROCESS | 24604 | 04:31:37 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51535/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:37 INFO - PROCESS | 24604 | RSS: Main: 148680704 04:31:37 INFO - PROCESS | 24604 | 04:31:41 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51535/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:41 INFO - PROCESS | 24604 | RSS: Main: 147030016 04:31:41 INFO - PROCESS | 24604 | 04:31:44 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51535/tests/kraken/driver.html?testName=json-parse-financial) 04:31:45 INFO - PROCESS | 24604 | RSS: Main: 146509824 04:31:45 INFO - PROCESS | 24604 | 04:31:47 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51535/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:47 INFO - PROCESS | 24604 | RSS: Main: 147767296 04:31:47 INFO - PROCESS | 24604 | 04:31:49 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:50 INFO - PROCESS | 24604 | RSS: Main: 149037056 04:31:50 INFO - PROCESS | 24604 | 04:31:52 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:52 INFO - PROCESS | 24604 | RSS: Main: 148922368 04:31:52 INFO - PROCESS | 24604 | 04:31:55 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:31:56 INFO - PROCESS | 24604 | RSS: Main: 147034112 04:31:56 INFO - PROCESS | 24604 | 04:31:58 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:31:59 INFO - PROCESS | 24604 | RSS: Main: 148545536 04:31:59 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51535/tests/kraken/driver.html?testName=ai-astar) 04:32:01 INFO - PROCESS | 24604 | RSS: Main: 149311488 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | __start_tp_report 04:32:01 INFO - PROCESS | 24604 | _x_x_mozilla_page_load 04:32:01 INFO - PROCESS | 24604 | _x_x_mozilla_page_load_details 04:32:01 INFO - PROCESS | 24604 | |i|pagename|runs| 04:32:01 INFO - PROCESS | 24604 | |0;ai-astar;113;109;114;113;113;123;116;112;112;113 04:32:01 INFO - PROCESS | 24604 | |1;audio-beat-detection;165;130;161;165;143;155;163;136;174;134 04:32:01 INFO - PROCESS | 24604 | |2;audio-dft;166;165;167;166;167;177;164;165;168;161 04:32:01 INFO - PROCESS | 24604 | |3;audio-fft;77;72;76;76;119;77;74;74;74;94 04:32:01 INFO - PROCESS | 24604 | |4;audio-oscillator;102;98;136;97;98;98;132;97;99;134 04:32:01 INFO - PROCESS | 24604 | |5;imaging-gaussian-blur;110;110;110;111;110;110;110;110;109;110 04:32:01 INFO - PROCESS | 24604 | |6;imaging-darkroom;149;149;148;147;147;149;147;148;147;147 04:32:01 INFO - PROCESS | 24604 | |7;imaging-desaturate;96;96;96;96;96;97;96;97;96;96 04:32:01 INFO - PROCESS | 24604 | |8;json-parse-financial;72;73;72;77;71;72;74;75;75;70 04:32:01 INFO - PROCESS | 24604 | |9;json-stringify-tinderbox;65;67;66;66;68;66;66;68;67;66 04:32:01 INFO - PROCESS | 24604 | |10;stanford-crypto-aes;83;85;86;93;92;84;84;85;85;83 04:32:01 INFO - PROCESS | 24604 | |11;stanford-crypto-ccm;126;132;119;120;122;120;128;135;132;124 04:32:01 INFO - PROCESS | 24604 | |12;stanford-crypto-pbkdf2;137;152;140;145;147;136;147;142;148;161 04:32:01 INFO - PROCESS | 24604 | |13;stanford-crypto-sha256-iterative;71;73;70;73;74;71;73;72;75;72 04:32:01 INFO - PROCESS | 24604 | __end_tp_report 04:32:01 INFO - PROCESS | 24604 | __start_cc_report 04:32:01 INFO - PROCESS | 24604 | _x_x_mozilla_cycle_collect,782 04:32:01 INFO - PROCESS | 24604 | __end_cc_report 04:32:01 INFO - PROCESS | 24604 | __startTimestamp1452861121408__endTimestamp 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | ------- Summary: start ------- 04:32:01 INFO - PROCESS | 24604 | Number of tests: 14 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.00 stddev:3.68 (3.3%) stddev-sans-first:3.89 04:32:01 INFO - PROCESS | 24604 | Values: 113.0 109.0 114.0 113.0 113.0 123.0 116.0 112.0 112.0 113.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:162.00 stddev:15.54 (9.6%) stddev-sans-first:15.83 04:32:01 INFO - PROCESS | 24604 | Values: 165.0 130.0 161.0 165.0 143.0 155.0 163.0 136.0 174.0 134.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#2] audio-dft Cycles:10 Average:166.60 Median:166.50 stddev:4.14 (2.5%) stddev-sans-first:4.39 04:32:01 INFO - PROCESS | 24604 | Values: 166.0 165.0 167.0 166.0 167.0 177.0 164.0 165.0 168.0 161.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:14.61 (19.2%) stddev-sans-first:15.42 04:32:01 INFO - PROCESS | 24604 | Values: 77.0 72.0 76.0 76.0 119.0 77.0 74.0 74.0 74.0 94.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:97.50 stddev:17.27 (17.7%) stddev-sans-first:18.12 04:32:01 INFO - PROCESS | 24604 | Values: 102.0 98.0 136.0 97.0 98.0 98.0 132.0 97.0 99.0 134.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:32:01 INFO - PROCESS | 24604 | Values: 110.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 109.0 110.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 04:32:01 INFO - PROCESS | 24604 | Values: 149.0 149.0 148.0 147.0 147.0 149.0 147.0 148.0 147.0 147.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:32:01 INFO - PROCESS | 24604 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#8] json-parse-financial Cycles:10 Average:73.10 Median:73.50 stddev:2.13 (2.9%) stddev-sans-first:2.22 04:32:01 INFO - PROCESS | 24604 | Values: 72.0 73.0 72.0 77.0 71.0 72.0 74.0 75.0 75.0 70.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.50 stddev:0.97 (1.5%) stddev-sans-first:0.87 04:32:01 INFO - PROCESS | 24604 | Values: 65.0 67.0 66.0 66.0 68.0 66.0 66.0 68.0 67.0 66.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.00 stddev:3.56 (4.2%) stddev-sans-first:3.61 04:32:01 INFO - PROCESS | 24604 | Values: 83.0 85.0 86.0 93.0 92.0 84.0 84.0 85.0 85.0 83.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:127.00 stddev:5.75 (4.5%) stddev-sans-first:6.10 04:32:01 INFO - PROCESS | 24604 | Values: 126.0 132.0 119.0 120.0 122.0 120.0 128.0 135.0 132.0 124.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:147.00 stddev:7.44 (5.1%) stddev-sans-first:7.23 04:32:01 INFO - PROCESS | 24604 | Values: 137.0 152.0 140.0 145.0 147.0 136.0 147.0 142.0 148.0 161.0 04:32:01 INFO - PROCESS | 24604 | 04:32:01 INFO - PROCESS | 24604 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:1.51 (2.1%) stddev-sans-first:1.51 04:32:01 INFO - PROCESS | 24604 | Values: 71.0 73.0 70.0 73.0 74.0 71.0 73.0 72.0 75.0 72.0 04:32:01 INFO - PROCESS | 24604 | -------- Summary: end -------- 04:32:01 INFO - PROCESS | 24604 | 04:32:02 INFO - TEST-INFO | 24604: exit 0 04:32:02 INFO - TEST-OK | kraken | took 61380ms 04:32:02 INFO - TEST-START | v8_7 04:32:02 INFO - operating with platform_type : linux_ 04:32:02 INFO - Initialising browser for v8_7 test... 04:32:02 INFO - TEST-INFO | started process 24888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplZV7Ai/profile http://localhost:51535/getInfo.html) 04:32:06 INFO - PROCESS | 24888 | 04:32:06 INFO - PROCESS | 24888 | (process:24963): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:32:06 INFO - PROCESS | 24888 | __metrics Screen width/height:1600/1200 04:32:06 INFO - PROCESS | 24888 | colorDepth:24 04:32:06 INFO - PROCESS | 24888 | Browser inner width/height: 1024/697 04:32:06 INFO - PROCESS | 24888 | __metrics 04:32:06 INFO - PROCESS | 24888 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:32:07 INFO - TEST-INFO | 24888: exit 0 04:32:07 INFO - Browser initialized. 04:32:07 INFO - Running cycle 1/1 for v8_7 test... 04:32:07 INFO - TEST-INFO | started process 25012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplZV7Ai/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:09 INFO - PROCESS | 25012 | 04:32:09 INFO - PROCESS | 25012 | (process:25070): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:32:19 INFO - PROCESS | 25012 | RSS: Main: 150781952 04:32:19 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | Cycle 1(1): loaded http://localhost:51535/tests/v8_7/run.html (next: http://localhost:51535/tests/v8_7/run.html) 04:32:42 INFO - PROCESS | 25012 | RSS: Main: 146055168 04:32:42 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | __start_tp_report 04:32:42 INFO - PROCESS | 25012 | _x_x_mozilla_page_load 04:32:42 INFO - PROCESS | 25012 | _x_x_mozilla_page_load_details 04:32:42 INFO - PROCESS | 25012 | |i|pagename|runs| 04:32:42 INFO - PROCESS | 25012 | |0;Richards;167.7570877369569 04:32:42 INFO - PROCESS | 25012 | |1;DeltaBlue;188.00526414739613 04:32:42 INFO - PROCESS | 25012 | |2;Encrypt;278.1641168289291 04:32:42 INFO - PROCESS | 25012 | |3;Decrypt;5191.709844559586 04:32:42 INFO - PROCESS | 25012 | |4;RayTrace;1094.0919037199126 04:32:42 INFO - PROCESS | 25012 | |5;Earley;713.7758743754462 04:32:42 INFO - PROCESS | 25012 | |6;Boyer;12370.37037037037 04:32:42 INFO - PROCESS | 25012 | |7;RegExp;43812.5 04:32:42 INFO - PROCESS | 25012 | |8;Splay;600.3594967046135 04:32:42 INFO - PROCESS | 25012 | |9;NavierStokes;4845.410628019324 04:32:42 INFO - PROCESS | 25012 | __end_tp_report 04:32:42 INFO - PROCESS | 25012 | __startTimestamp1452861162637__endTimestamp 04:32:42 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | ------- Summary: start ------- 04:32:42 INFO - PROCESS | 25012 | Number of tests: 10 04:32:42 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | [#0] Richards Cycles:1 Average:167.76 Median:167.76 stddev:0.00 (0.0%) 04:32:42 INFO - PROCESS | 25012 | Values: 167.8 04:32:42 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | [#1] DeltaBlue Cycles:1 Average:188.01 Median:188.01 stddev:0.00 (0.0%) 04:32:42 INFO - PROCESS | 25012 | Values: 188.0 04:32:42 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 04:32:42 INFO - PROCESS | 25012 | Values: 278.2 04:32:42 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 04:32:42 INFO - PROCESS | 25012 | Values: 5191.7 04:32:42 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | [#4] RayTrace Cycles:1 Average:1094.09 Median:1094.09 stddev:0.00 (0.0%) 04:32:42 INFO - PROCESS | 25012 | Values: 1094.1 04:32:42 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | [#5] Earley Cycles:1 Average:713.78 Median:713.78 stddev:0.00 (0.0%) 04:32:42 INFO - PROCESS | 25012 | Values: 713.8 04:32:42 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 04:32:42 INFO - PROCESS | 25012 | Values: 12370.4 04:32:42 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | [#7] RegExp Cycles:1 Average:43812.50 Median:43812.50 stddev:0.00 (0.0%) 04:32:42 INFO - PROCESS | 25012 | Values: 43812.5 04:32:42 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | [#8] Splay Cycles:1 Average:600.36 Median:600.36 stddev:0.00 (0.0%) 04:32:42 INFO - PROCESS | 25012 | Values: 600.4 04:32:42 INFO - PROCESS | 25012 | 04:32:42 INFO - PROCESS | 25012 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 04:32:42 INFO - PROCESS | 25012 | Values: 4845.4 04:32:42 INFO - PROCESS | 25012 | -------- Summary: end -------- 04:32:42 INFO - PROCESS | 25012 | 04:32:43 INFO - TEST-INFO | 25012: exit 0 04:32:43 INFO - TEST-OK | v8_7 | took 41106ms 04:32:43 INFO - SUITE-END | took 1216s 04:32:43 INFO - Completed test suite (00:20:16) 04:32:43 INFO - Working with test: dromaeo_css 04:32:43 INFO - Generating results file: dromaeo_css 04:32:43 INFO - Working with test: kraken 04:32:43 INFO - Generating results file: kraken 04:32:43 INFO - javascript benchmark 04:32:43 INFO - Working with test: v8_7 04:32:43 INFO - Generating results file: v8_7 04:32:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:32:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:32:43 INFO - process_Request line: dromaeo_css 6117.80 graph.html#tests=[[72,94,43]] 04:32:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:32:43 INFO - process_Request line: kraken 1546.70 graph.html#tests=[[232,94,43]] 04:32:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:32:43 INFO - process_Request line: v8_7 20198.95 graph.html#tests=[[230,94,43]] 04:32:43 INFO - RETURN: dromaeo_css: 6117.80 04:32:43 INFO - RETURN: kraken: 1546.70 04:32:43 INFO - RETURN: v8_7: 20198.95 04:32:43 INFO - javascript benchmark 04:32:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2654.8938042478303, 2668.2262143978246, 2742.657167854017, 2743.0536464919596, 2757.159066484722, 4492.865214043584, 4566.429196350452, 4598.954010459895, 4610.17016936952, 4622.884427889305, 4507.3689683444345, 4539.477960034597, 4556.84051058213, 4597.88505287368, 4625.190591646465, 4198.6431153352005, 4206.179794939988, 4250.681198910079, 4266.637335826458, 4299.462567179103, 4271.145770845827, 4324.286492728712, 4326.524082350938, 4348.739075655455, 4363.585459381354, 4020.2562525932503, 4164.416981622575, 4185.895352616179, 4297.333913243452, 4301.591348821873, 4237.0890258594245, 4244.660427165819, 4248.490181178247, 4266.935995960032, 4281.357796330544, 4212.7682977436225, 4221.514525829538, 4242.236397448458, 4277.165952639237, 4280.935785963213, 4431.09162621665, 4498.347739577743, 4501.504834468205, 4521.299198624219, 4593.56361145694, 4889.706617602955, 4898.289747986522, 4903.705777653352, 4909.386326709161, 4925.876853078666, 4932.926006109911, 4934.0, 4935.062338155739, 4938.333325001115, 4981.750912454399, 4516.932246016312, 4558.247889098328, 4601.6548758842555, 4610.446746390455, 4636.0, 5021.171506701427, 5029.899402011939, 5032.6225533084435, 5039.672421292605, 5097.6941383517105, 4851.684640498356, 4852.369192005017, 4852.56326930578, 4861.586765124934, 4901.166801643729, 4763.04739052191, 4841.806327746921, 4910.729909854992, 4939.259111133359, 5001.89996200074, 4816.494268101869, 4830.0, 4834.178189707758, 4841.709497430165, 4881.9023619528125, 4689.812407503729, 4783.1390349737385, 4791.808327666854, 4798.95201047985, 4836.226203807374, 4013.418054382098, 4068.4507591475362, 4113.8971525711495, 4115.97942010288, 4144.274751918462, 3607.7474576779373, 3636.399994001013, 3644.599094099647, 3655.2689462107155, 3670.100825297819, 4169.937450938239, 4244.087521182961, 4272.401863739079, 4274.978625106854, 4289.335153051282, 4882.731449770296, 4901.215805471179, 4903.166461701519, 4905.994271174401, 4952.2819191217795, 4238.957610423918, 4251.4685664291965, 4261.232978063978, 4271.402003719481, 4298.613124818781, 4194.916101678011, 4287.721298115613, 4296.398504209351, 4352.194843953878, 4383.320585309219, 4705.929411058768, 4709.505501922317, 4712.340272361941, 4724.173269677793, 4725.10223057618, 4906.607471402351, 4938.506149385033, 4956.975215123901, 4975.228839529878, 4995.800167993385, 4490.371348011216, 4575.496695363574, 4667.953320466888, 4683.555062269079, 4748.05038992196, 4824.6863953842885, 4834.20235661112, 4838.467768545387, 4848.224284114524, 4850.708957462563, 4874.0495603357, 4879.682820616648, 4895.388076490439, 4912.606991440748, 4950.752462376939, 4672.906541869075, 4729.314249433882, 4746.027064451848, 4768.737719425465, 4805.5915247204375, 4678.157931572349, 4701.482836888008, 4703.764811759467, 4747.0, 4761.928571071506, 4499.617532509773, 4604.907901842012, 4618.237990731492, 4628.305754136772, 4643.791029403617, 4758.571728544448, 4780.163471392423, 4837.612990960644, 4842.104210721028, 4887.511248875084, 4594.816207351669, 4599.0, 4604.033153037765, 4641.512641172628, 4648.2330415481065], "unit": "score", "name": "dojo.html", "value": 4503.510475403458}, {"lowerIsBetter": false, "replicates": [501.12803721524534, 510.9897802043959, 528.3685995235693, 536.4153073150266, 593.0007936626787, 32349.118105827303, 33012.504812427775, 33050.504242436386, 33075.33849323012, 33223.33553328932, 32460.837695811548, 32531.837340813323, 33087.0, 33127.83436082822, 33155.33689326218, 7383.224761400043, 7637.701590729589, 7660.2722741339485, 7665.846683066336, 7676.385889128885, 7538.359239464652, 7634.885476717854, 7644.579548124851, 7666.348360389374, 7671.923280767204, 7643.082830060401, 7690.961545192266, 7698.384129269673, 7703.191164927686, 7729.61351932404, 7605.467617266793, 7701.768946931601, 7706.190849960757, 7715.845683086363, 7726.690932362699, 7545.245475452466, 7634.351080158138, 7677.30904218623, 7685.884711729329, 7691.23087691232, 33280.500792488136, 33610.1597460063, 33759.493607595905, 33769.49345759815, 33881.83059084714, 3023.470892593787, 3130.624325080982, 3131.5459258407404, 3260.4294248506417, 3416.0, 27545.0, 27988.0, 28183.295417614518, 28291.0, 28472.715272847214, 3368.6986752982216, 3407.165244515085, 3421.674940880612, 3443.984024712691, 3503.0016445312963, 210908.0, 212220.0, 212357.0, 212401.0, 212510.0, 51944.0, 52126.478735212164, 52176.21735673968, 52180.0, 52192.47807521952, 47831.0, 48815.51184488181, 56443.43556564464, 57476.0, 57512.424875751545, 14269.500567480089, 14296.0, 14437.783433248509, 14461.710765784836, 14482.637934051521, 11124.61063862761, 11134.053605443465, 11165.553377864795, 11177.329360238411, 11231.0, 17309.65380692404, 17531.474055778348, 17614.647707045788, 17625.383111591033, 17685.469435916944, 7226.891596626055, 7414.480986330905, 7469.477136600494, 7479.401647868158, 7487.588182649898, 869.6564856881496, 891.3225948279354, 897.6185121323412, 905.0316161707042, 997.9970130019284, 25035.248942531754, 25328.493430131664, 25562.616560751605, 25572.744272557407, 26024.219273421448, 962.629387685746, 963.426761077158, 991.7768502086973, 1001.7746007148334, 1081.8160912644869, 11722.88277117235, 11787.646370608896, 11819.399732058933, 11909.404529773477, 11936.403179841147, 252068.0, 254626.0, 255336.0, 255504.0, 255512.0, 43081.0, 43236.3514547282, 43299.567004329554, 43305.56694433015, 43720.562794371646, 1220.4934951995, 1225.3934302520308, 1232.7596118756935, 1239.8388209532702, 1249.4814651919532, 21737.456563586038, 22382.88808555947, 22750.544989100457, 22920.541589168457, 23243.76756232416, 34415.0, 34578.308433831684, 34605.0, 34845.12887177841, 35309.117272068404, 242781.0, 243250.0, 243973.0, 244329.0, 245009.0, 26973.325666858487, 28214.71785282121, 28806.0, 28811.0, 28865.7113428863, 31068.68931310658, 31332.37335253328, 31472.213194670316, 32000.35999279955, 32028.03915882527, 27801.44397112006, 27860.860695696392, 27986.0, 28126.718732813228, 28142.15573532797, 27564.448711026067, 27705.168844934684, 27790.722092778815, 27967.58048629313, 28216.85891570529, 31377.0, 31386.372272554876, 31446.371072578877, 31792.04623861288, 31875.6812431882, 25757.613635795104, 26821.597676035264, 28320.0, 28641.0, 28723.712762872103, 21998.34004979853, 22388.88805555962, 22793.430164246027, 22859.428514287276, 22953.770462295164], "unit": "score", "name": "ext.html", "value": 15936.984206371233}, {"lowerIsBetter": false, "replicates": [350.2871656179675, 350.8859620623298, 351.1011809766995, 352.2110472541507, 354.71445486383453, 13773.51792687256, 14220.644483887909, 15191.240437978113, 15753.684926301496, 16119.919400402996, 14290.714185716279, 14385.280735963212, 15353.923230383833, 15410.768838467431, 15460.226988650578, 4376.6279866211335, 4424.3142312941545, 4585.839495617654, 4587.243104887706, 4600.1259760645535, 4481.551844815525, 4559.680822342438, 4584.037352156051, 4584.381108550353, 4584.931226031612, 4587.931181032271, 4611.446626404836, 4777.713337199762, 4809.422869255677, 4810.97594512027, 4744.240921452551, 4860.708357498544, 4896.46138924718, 5287.47125287472, 5293.073712100367, 5080.13637681595, 5114.744262786846, 5118.872028199287, 5121.027004869063, 5123.641345105844, 13009.479620815251, 17605.911970440065, 17995.460136195936, 18160.90919545407, 18290.542736431697, 1829.7438358629802, 1867.2624313396132, 1909.312647446918, 1922.298361098203, 1926.6050459655878, 8183.754487365389, 8626.78433039179, 9389.906100938972, 9889.901100989042, 12093.697657558543, 1725.8791884568086, 1796.7215081662364, 1908.3702378215155, 1967.911443985024, 2002.3692536850845, 40251.0, 41794.79102604467, 41916.580834191576, 41948.16103677909, 42488.78755606233, 9368.765780855532, 9413.623455061857, 9434.764130896783, 9456.196223321094, 9497.192738617296, 11452.885471145182, 11699.824502632468, 11761.0, 11873.940630296793, 11874.821877671842, 6892.655367231619, 7127.572345659277, 7212.639368031578, 7224.060872086595, 7270.781876543712, 6972.163340399185, 7065.717371305193, 7070.8939365909555, 7087.184973728087, 7170.784876453715, 4122.134351786099, 4191.559886211965, 4215.515215750167, 4246.723962942398, 4260.765657888784, 1801.3335066025393, 1823.7993820679715, 1836.3205613922935, 1848.7966323704381, 1885.7359969604267, 828.225609055535, 863.5078005536784, 867.6919693508839, 886.1670030171618, 941.3786900645541, 14754.188519631309, 14769.33537990793, 14992.325345359484, 15256.38974441032, 15386.769198462032, 829.5810615639064, 849.5072857742495, 852.2500199824239, 856.2037305306125, 892.1836519584507, 8557.0, 8917.464952102764, 8988.955055224813, 9120.361574689841, 9236.307276954121, 297620.0, 302555.0, 303352.0, 303406.0, 454504.0, 39204.60795392067, 45432.772836135606, 52559.47440525546, 55344.72327638336, 56835.43164568384, 1066.4507778494083, 1087.8857719939451, 1089.3518356577824, 1089.5750657243682, 1095.4030053620795, 12765.48938042505, 12841.871581284442, 13765.0, 13887.58337249884, 13938.024338296222, 26732.866335668197, 27557.586636200875, 27863.16410507688, 29785.85107074451, 31131.844340778152, 35118.47322290219, 36115.0, 36775.632243678294, 36990.630093699794, 37363.813180933925, 3155.684431556918, 3531.6579699713943, 6098.329183789869, 6485.967570162307, 6518.706658200487, 8483.490990540588, 9430.858537122085, 9462.952685236529, 9551.952240238754, 9552.331336806636, 7869.291763741291, 8353.916460835313, 8403.915960840313, 8475.364347673825, 8486.575671216291, 8507.064222935349, 8611.6985905493, 8647.264982476308, 8731.607077681647, 8902.688405905763, 8565.400421970402, 9072.50101244438, 9170.174684278447, 9294.674686386215, 9437.811243775224, 6160.10678451631, 6833.077534532775, 6852.383285504328, 6876.0, 6882.483813713891, 8143.714969976022, 8323.458975166595, 8395.202455766692, 8520.19058189471, 8524.0], "unit": "score", "name": "jquery.html", "value": 7251.734853650262}, {"lowerIsBetter": false, "replicates": [1390.8609139086088, 1391.0888368118883, 1527.3737767515322, 1718.9570260743471, 1736.5919009032882, 6235.875282494348, 6358.936410635893, 7207.17117531484, 7357.558546487207, 7371.115466144063, 6853.588784672923, 6856.862862742742, 6940.6876690548925, 6957.443404527638, 6971.128608923885, 2134.530403311273, 2151.1180416029433, 2167.7832216778274, 2168.1327469012363, 2171.7393912730417, 2137.059693734752, 2154.6013987412302, 2183.967240491386, 2185.8579192352527, 2186.0053675577656, 2186.212963333199, 2202.0861342542826, 2202.746684131321, 2203.2398822406326, 2206.735191776989, 2185.4317877351923, 2193.144673577306, 2195.736511618608, 2196.4399078234947, 2197.56048790241, 2106.9789302106938, 2137.5404288077984, 2138.5081431270896, 2139.1015773375066, 2145.2706079932896, 7291.307325804093, 7321.560706357635, 7369.710300697357, 7373.152087509898, 7392.112946446461, 4287.871363859089, 4355.303151495746, 4374.147041326943, 4380.189664912002, 4388.71473354231, 2691.3944362518473, 2693.9730602693917, 2790.330320723032, 2790.9023184188454, 2794.636697229347, 820.7168526858225, 835.4486039214089, 862.9741107766777, 871.372611719561, 874.2394117118148, 9830.754231144207, 9839.852402213972, 9896.802063958752, 9928.007199280015, 9934.304598678096, 4016.8393264269685, 4032.334664780337, 4102.979485102555, 4136.0, 4142.958570414317, 8573.528455934858, 8600.311975041981, 8606.741797746077, 8607.26838218746, 8607.655693772303, 4375.671824613103, 4376.431063961664, 4389.780510974439, 4412.0, 4432.889177770517, 3453.689167974894, 3534.929301413957, 3852.3836186210074, 3965.920681586352, 3976.343903255988, 3469.358168738741, 3469.6877281044826, 3508.5965114011706, 3513.80674062929, 3530.4880792284976, 1127.1546340244815, 1137.5506674863382, 1163.3543383422113, 1164.3537836500655, 1166.562539047857, 1037.527924794217, 1041.2763129624839, 1051.7055224537141, 1069.1553672598716, 1080.9729756756144, 6559.147310849559, 6590.868182636321, 6591.769288074895, 6597.30728273534, 6621.503387245976, 432.6992740045638, 1080.6595922284455, 1139.3050239353988, 1148.311013391975, 1159.4202898550725, 4795.976020119877, 4880.243562247857, 4894.0, 4894.706317620954, 4898.21628539432, 8369.455985360932, 8386.706465273686, 8531.146885311418, 8573.657053717781, 8609.69866054685, 8356.540390278471, 8377.83244335122, 8392.0, 8423.284020858173, 8488.278496327881, 6829.658517074126, 6902.344277293649, 6904.4131248844415, 6917.342852429011, 6934.16789985205, 6192.59748116371, 6271.560990730605, 6314.55798094129, 6319.96840015797, 6323.336049714714, 7605.543667379975, 7608.391328693802, 7735.265149810984, 7746.767596972099, 7808.84382312362, 7786.26030527099, 7832.725854595062, 7954.363650908029, 8011.679532818622, 8017.398695098008, 5709.429057094423, 5831.650100993954, 6457.128287681103, 6599.835004124935, 6715.127033485615, 6442.420182183439, 6471.320511346241, 6474.741010359533, 6483.027545868157, 6499.1876015498065, 6102.816915492543, 6206.382344169437, 6319.146915166394, 6580.078788969452, 6593.109930159367, 6151.3541078186145, 6187.535934804998, 6315.55791094619, 6328.335524770017, 6341.0805433212845, 6402.231732192166, 6459.257185423737, 6460.515461340512, 6478.514111441755, 6482.384173503509, 6097.024476083805, 6180.072989051499, 6190.102435146789, 6214.658193799203, 6219.253689557282, 6101.725422355916, 6105.358937311518, 6157.6613286269685, 6160.229971253593, 6161.661108639068], "unit": "score", "name": "mootools.html", "value": 4135.5601005764565}, {"lowerIsBetter": false, "replicates": [317.90303957293025, 328.382640635605, 330.30141251253605, 335.163766402825, 336.436468914568, 5487.670739755617, 5503.972480137599, 5529.972350138254, 5591.38494765576, 5685.033544297469, 5467.316585426822, 5510.173473978905, 5529.30883639545, 5540.584456165783, 5547.11246200608, 4304.397384366192, 4310.4611923509565, 4311.611954924057, 4311.633511151548, 4315.158544083889, 4307.741535507864, 4313.482382114151, 4315.956840431587, 4316.525182229952, 4322.740635561876, 4175.290200665894, 4258.7870606469705, 4274.4229529013655, 4279.593438623326, 4281.122369914176, 4188.62302392783, 4258.127083947783, 4269.167512335081, 4272.9145417091795, 4282.207791558571, 3706.814659267026, 3707.3326801175776, 3710.406334986389, 3714.275716235335, 3715.1269451678836, 5331.1470164773455, 5344.064788662007, 5348.358197016383, 5355.3305836770405, 5360.624756267063, 4899.069176856386, 4902.558769710743, 4912.115819152551, 4919.26211068339, 4926.137925862996, 5580.86047848803, 5732.283464566929, 5802.738876750556, 5809.6804675742815, 5831.358550559435, 4010.9598904010877, 4016.6385025347568, 4017.6183262590007, 4020.4170395292517, 4021.4973128358956, 6003.879922401571, 6083.847903802441, 6088.8782224356155, 6093.451589356935, 6109.786157484511, 4024.476818013698, 4143.917121657611, 4144.647704945053, 4148.2947898857265, 4161.604647558477, 4192.0, 4193.098483825992, 4195.098053918422, 4197.622214000755, 4204.285271503852, 4804.327394164819, 4814.855554333376, 4840.588549973221, 4868.488808675109, 4881.560659540658, 5779.393163717833, 5787.363390027093, 5795.159701843293, 5820.24336836217, 5852.736626851802, 1404.6909679870616, 1483.7032593481347, 1485.049568276304, 1508.1328236264192, 1511.6372070702953, 953.0707560128819, 1008.0625018732649, 1009.5204777730519, 1018.5263852308713, 1022.2077889635592, 4933.186024305949, 5003.949960500421, 5009.323741294951, 5011.0, 5034.572061374824, 5876.676782776988, 5970.34326224115, 5992.940070599326, 5994.640321580632, 6000.21997140369, 4994.300797888299, 5009.298698182258, 5010.749462526859, 5026.170681837529, 5039.69761814285, 3203.5515027896113, 3229.7254733347927, 3235.1588586967086, 3244.6430892601793, 3245.8214798186327, 5461.42655021225, 5610.551155907518, 5612.1581762735095, 5614.9438505615235, 5619.522340601095, 6148.569600128038, 6187.690615469209, 6207.751689932443, 6212.285587157535, 6217.191765070512, 5592.5246354059545, 5604.103343465107, 5605.943940560543, 5606.60753747242, 5617.101263797855, 5979.312379076462, 5980.491658208927, 5980.611260268069, 5984.162217289496, 5992.730327135377, 5747.568932330176, 5813.215215945793, 5895.587308888336, 5914.970425147847, 5990.880182396415, 5678.801241956677, 5689.0, 5712.65724056558, 5726.398728133652, 5728.684922329312, 4252.298370768788, 4277.593628605277, 4328.783560822009, 4337.609615134653, 4341.066670665822, 5899.793507227399, 6024.518038556817, 6027.186329845415, 6035.456808887221, 6040.697965101639, 5785.710714464344, 5788.9131663024245, 5797.594168408171, 5800.912986305125, 5807.94192058074, 5712.42875712442, 5790.652560846363, 5825.563082768725, 5855.151003104611, 5890.322612899571, 5678.829635110953, 5682.971585142048, 5699.230603868425, 5701.059325211294, 5738.053221218453, 5849.210356601804, 5849.795257165979, 5863.120531920246, 5870.207521984477, 5892.145638882424, 5576.302962129734, 5643.294588176478, 5687.1753595729215, 5689.857753556194, 5690.857728556819], "unit": "score", "name": "prototype.html", "value": 4359.31057044613}, {"lowerIsBetter": false, "replicates": [668.4451904918918, 682.6382017530708, 708.5713143548156, 736.2747693521883, 757.923748277446, 11282.774344513115, 11471.19701620887, 11488.425578721062, 11500.539978400875, 11532.192746507759, 10895.400752958603, 11823.408829558532, 11831.0, 11838.585649502247, 11859.288442693445, 768.7578412799978, 770.6647608290411, 783.4085265624445, 788.7239466186846, 791.3115589437198, 777.708359365238, 779.7426849139798, 784.1335324466439, 785.2069409895989, 788.4756636836526, 814.1207495904439, 815.3151352863594, 816.4529765057396, 816.6243527977138, 818.3698552114868, 798.0, 798.9280964713146, 803.586153131138, 804.891339669143, 810.5096416667919, 599.6102533353355, 603.0803025386277, 603.616703393344, 604.4016423740509, 605.403677377787, 12291.877081229162, 12297.077719171008, 12383.257004579664, 12473.251604903644, 12781.488740450372, 10494.527746251437, 11152.721181970515, 11550.0, 12002.69993250167, 12122.454489547992, 9612.375195612263, 9702.75743106428, 9748.512574371323, 9784.11942925133, 9885.456299903502, 3273.558069660613, 3281.1305004173914, 3311.4536101543217, 3348.866045358207, 3423.845926933294, 40462.0, 40696.982575435555, 40872.0, 40956.38565421521, 40957.59042409567, 9153.77115572116, 9232.53837308132, 9380.90619093814, 9431.0, 9493.762655933519, 15717.685646287011, 15744.0, 15746.212689365486, 15816.209189540707, 15923.601909952113, 6303.36966303366, 6447.6453795041725, 6471.967640161769, 6501.0, 6587.440067594308, 3858.112634094174, 3881.9611803882162, 3889.902752431212, 3914.7455415398476, 3933.9016524587114, 2559.3345730110304, 2586.1465716313573, 2624.9868750656124, 2629.881655325515, 2640.2475294541346, 507.6294305157182, 508.1057339083166, 509.67380876238497, 515.0960065085751, 516.7803683434526, 477.0435277269053, 505.219435971425, 509.24685071026033, 531.8510816971177, 546.9863253418616, 6715.46276297895, 6793.898091528631, 6845.236615951994, 6963.1644202696, 6986.545874518241, 468.981240750373, 477.9044191161712, 494.81691774043117, 599.2389665125266, 615.547572534187, 3455.6371580984137, 3501.509788629594, 3645.198056427582, 3684.963150368462, 3694.9445758313645, 44453.55546444559, 44692.3296150558, 44803.55196448059, 44838.775806120764, 45155.0, 41237.96905077397, 41357.379639305436, 41720.0, 42090.316387344166, 42343.57656423396, 36271.81864090716, 36292.27415451676, 37498.25003499969, 38397.808010959765, 38489.42265866014, 7244.855102897807, 7262.273772622695, 7289.817754556178, 7297.306755858397, 7528.8494230116185, 28256.434871302048, 28695.13914582566, 28923.0, 29246.26884327909, 29492.115236542937, 35794.284114317044, 35829.64170358263, 35981.0, 36050.63949360578, 36991.260174796895, 9700.5149742514, 9800.215982721222, 9911.900880991097, 9971.900280997097, 10002.899971000197, 10650.201234907257, 10659.413732244491, 11050.33697978124, 11052.171087168334, 11259.155563332619, 10240.334378265388, 10312.175025997753, 10385.948070259903, 10522.421266830092, 10632.239791364495, 9926.751831204278, 9950.35322704022, 10272.948635256776, 10338.379697218192, 10427.94786026065, 10254.948725256327, 10277.794444110927, 10500.054995050483, 10563.577456901638, 10599.62901298451, 8953.194212520904, 9178.724638260863, 9247.445153290824, 9252.676156334495, 9313.720588382359, 8951.239144672516, 9113.225375842863, 9201.677941272023, 9271.851396625756, 9565.378250413702], "unit": "score", "name": "yui.html", "value": 5587.015763055506}], "name": "dromaeo_css", "value": 6117.799133300202}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 114.0, 113.0, 113.0, 123.0, 116.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.8}, {"lowerIsBetter": true, "replicates": [165.0, 130.0, 161.0, 165.0, 143.0, 155.0, 163.0, 136.0, 174.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 152.6}, {"lowerIsBetter": true, "replicates": [166.0, 165.0, 167.0, 166.0, 167.0, 177.0, 164.0, 165.0, 168.0, 161.0], "unit": "score", "name": "audio-dft", "value": 166.6}, {"lowerIsBetter": true, "replicates": [77.0, 72.0, 76.0, 76.0, 119.0, 77.0, 74.0, 74.0, 74.0, 94.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [102.0, 98.0, 136.0, 97.0, 98.0, 98.0, 132.0, 97.0, 99.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 148.0, 147.0, 147.0, 149.0, 147.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 77.0, 71.0, 72.0, 74.0, 75.0, 75.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 73.1}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 66.0, 66.0, 68.0, 66.0, 66.0, 68.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 86.0, 93.0, 92.0, 84.0, 84.0, 85.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [126.0, 132.0, 119.0, 120.0, 122.0, 120.0, 128.0, 135.0, 132.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [137.0, 152.0, 140.0, 145.0, 147.0, 136.0, 147.0, 142.0, 148.0, 161.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 70.0, 73.0, 74.0, 71.0, 73.0, 72.0, 75.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.4}], "name": "kraken", "value": 1546.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7570877369569], "unit": "score", "name": "Richards", "value": 210.43522200000004}, {"lowerIsBetter": false, "replicates": [188.00526414739613], "unit": "score", "name": "DeltaBlue", "value": 351.68164199999995}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1094.0919037199126], "unit": "score", "name": "RayTrace", "value": 676.3499459999998}, {"lowerIsBetter": false, "replicates": [713.7758743754462], "unit": "score", "name": "Earley", "value": 933.7146630000002}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [43812.5], "unit": "score", "name": "RegExp", "value": 20.792810271041354}, {"lowerIsBetter": false, "replicates": [600.3594967046135], "unit": "score", "name": "Splay", "value": 135.73700499001993}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20198.953381853706}]} 04:32:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20198.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1546.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6117.80"}}} 04:32:43 INFO - Return code: 0 04:32:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:32:43 INFO - # TBPL SUCCESS # 04:32:43 INFO - Running post-action listener: _resource_record_post_action 04:32:43 INFO - Running post-run listener: _resource_record_post_run 04:32:44 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541347840; Read time: 28; Write time: 421124 04:32:44 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 229310464; Read time: 0; Write time: 232480 04:32:44 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311173120; Read time: 28; Write time: 188608 04:32:44 INFO - Running post-run listener: _upload_blobber_files 04:32:44 INFO - Blob upload gear active. 04:32:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:44 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 04:32:44 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:32:44 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:32:45 INFO - (blobuploader) - INFO - Open directory for files ... 04:32:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:32:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:32:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:46 INFO - (blobuploader) - INFO - Done attempting. 04:32:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:32:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:32:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:47 INFO - (blobuploader) - INFO - Done attempting. 04:32:47 INFO - (blobuploader) - INFO - Iteration through files over. 04:32:47 INFO - Return code: 0 04:32:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:32:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:32:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0adb860309c68b319a4a5b0a7c8cf2fd3cfdb8625d6de327be9ddb91a9eb4d86ddf32777820d6b599b8b3454492d6e485d4e3ffb49fb576d6d3c782c17c544c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dac2571d34bf4a8a98b05decd6fd02f10daa661fa2e176923e3eedabdba9c72854a999290432415da7b02e51b0c17038b0bccf4bad297df8f29f5e37b240d453"} 04:32:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:32:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:32:47 INFO - Contents: 04:32:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0adb860309c68b319a4a5b0a7c8cf2fd3cfdb8625d6de327be9ddb91a9eb4d86ddf32777820d6b599b8b3454492d6e485d4e3ffb49fb576d6d3c782c17c544c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dac2571d34bf4a8a98b05decd6fd02f10daa661fa2e176923e3eedabdba9c72854a999290432415da7b02e51b0c17038b0bccf4bad297df8f29f5e37b240d453"} 04:32:47 INFO - Copying logs to upload dir... 04:32:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.941123 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-15 04:32:46.945755) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 04:32:46.946654) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0adb860309c68b319a4a5b0a7c8cf2fd3cfdb8625d6de327be9ddb91a9eb4d86ddf32777820d6b599b8b3454492d6e485d4e3ffb49fb576d6d3c782c17c544c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dac2571d34bf4a8a98b05decd6fd02f10daa661fa2e176923e3eedabdba9c72854a999290432415da7b02e51b0c17038b0bccf4bad297df8f29f5e37b240d453"} build_url:https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011116 build_url: 'https://queue.taskcluster.net/v1/task/P9sQTAbZTdy8LZMW1MmjRA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d0adb860309c68b319a4a5b0a7c8cf2fd3cfdb8625d6de327be9ddb91a9eb4d86ddf32777820d6b599b8b3454492d6e485d4e3ffb49fb576d6d3c782c17c544c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dac2571d34bf4a8a98b05decd6fd02f10daa661fa2e176923e3eedabdba9c72854a999290432415da7b02e51b0c17038b0bccf4bad297df8f29f5e37b240d453"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 04:32:46.986130) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 04:32:46.986467) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452859890.238456-1369712157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 04:32:47.070585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 04:32:47.070911) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 04:32:47.071220) ========= ========= Total master_lag: 0.52 =========