builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1452899952.55 results: success (0) buildid: 20160115145423 builduid: ca19588612b84ce6ba469e56eed51240 revision: 71dec72dcdd5a2318328cf74c22a4f8c967fbe2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.549384) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.549848) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.550134) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006390 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.590969) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.591239) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.655747) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.656000) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004661 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.722971) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.723492) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.723855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.724129) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 15:19:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2016-01-15 15:19:13 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094515 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.845873) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.846159) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022842 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.896024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:12.896358) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 71dec72dcdd5a2318328cf74c22a4f8c967fbe2c --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 71dec72dcdd5a2318328cf74c22a4f8c967fbe2c --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=b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 15:19:13,247 truncating revision to first 12 chars 2016-01-15 15:19:13,247 Setting DEBUG logging. 2016-01-15 15:19:13,248 attempt 1/10 2016-01-15 15:19:13,248 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/71dec72dcdd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 15:19:13,531 unpacking tar archive at: mozilla-central-71dec72dcdd5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.591838 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:13.500517) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:13.500819) ========= echo '%(revision)s' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004486 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:13.550869) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:13.551150) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:13.562061) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:13.562303) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 15:19:13.562659) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-15 15:19:13.562941) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:19:13 INFO - MultiFileLogger online at 20160115 15:19:13 in /builds/slave/test 15:19:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 15:19:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:19:14 INFO - {'append_to_log': False, 15:19:14 INFO - 'base_work_dir': '/builds/slave/test', 15:19:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:19:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:19:14 INFO - 'branch': 'Firefox-Non-PGO', 15:19:14 INFO - 'buildbot_json_path': 'buildprops.json', 15:19:14 INFO - 'config_files': ('talos/linux_config.py',), 15:19:14 INFO - 'default_actions': ('clobber', 15:19:14 INFO - 'read-buildbot-config', 15:19:14 INFO - 'download-and-extract', 15:19:14 INFO - 'populate-webroot', 15:19:14 INFO - 'create-virtualenv', 15:19:14 INFO - 'install', 15:19:14 INFO - 'run-tests'), 15:19:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:19:14 INFO - 'download_minidump_stackwalk': True, 15:19:14 INFO - 'download_symbols': 'ondemand', 15:19:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:19:14 INFO - 'tooltool.py': '/tools/tooltool.py', 15:19:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:19:14 INFO - '/tools/misc-python/virtualenv.py')}, 15:19:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:19:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:19:14 INFO - 'installer_path': 'installer.exe', 15:19:14 INFO - 'log_level': 'info', 15:19:14 INFO - 'log_name': 'talos', 15:19:14 INFO - 'log_to_console': True, 15:19:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:19:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:19:14 INFO - 'opt_config_files': (), 15:19:14 INFO - 'pip_index': False, 15:19:14 INFO - 'sps_profile': False, 15:19:14 INFO - 'sps_profile_interval': 0, 15:19:14 INFO - 'suite': 'dromaeojs', 15:19:14 INFO - 'system_bits': '32', 15:19:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:19:14 INFO - 'title': 'talos-linux64-ix-007', 15:19:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:19:14 INFO - 'use_talos_json': True, 15:19:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:19:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:19:14 INFO - 'work_dir': 'build'} 15:19:14 INFO - ##### 15:19:14 INFO - ##### Running clobber step. 15:19:14 INFO - ##### 15:19:14 INFO - Running pre-action listener: _resource_record_pre_action 15:19:14 INFO - Running main action method: clobber 15:19:14 INFO - rmtree: /builds/slave/test/build 15:19:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:19:14 INFO - Running post-action listener: _resource_record_post_action 15:19:14 INFO - ##### 15:19:14 INFO - ##### Running read-buildbot-config step. 15:19:14 INFO - ##### 15:19:14 INFO - Running pre-action listener: _resource_record_pre_action 15:19:14 INFO - Running main action method: read_buildbot_config 15:19:14 INFO - Using buildbot properties: 15:19:14 INFO - { 15:19:14 INFO - "project": "", 15:19:14 INFO - "product": "firefox", 15:19:14 INFO - "script_repo_revision": "production", 15:19:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:19:14 INFO - "repository": "", 15:19:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:19:14 INFO - "buildid": "20160115145423", 15:19:14 INFO - "pgo_build": "False", 15:19:14 INFO - "basedir": "/builds/slave/test", 15:19:14 INFO - "buildnumber": 391, 15:19:14 INFO - "slavename": "talos-linux64-ix-007", 15:19:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:19:14 INFO - "platform": "ubuntu64_hw", 15:19:14 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:19:14 INFO - "branch": "mozilla-central", 15:19:14 INFO - "repo_path": "mozilla-central", 15:19:14 INFO - "revision": "71dec72dcdd5a2318328cf74c22a4f8c967fbe2c", 15:19:14 INFO - "stage_platform": "linux64", 15:19:14 INFO - "builduid": "ca19588612b84ce6ba469e56eed51240", 15:19:14 INFO - "slavebuilddir": "test" 15:19:14 INFO - } 15:19:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:19:14 INFO - Running post-action listener: _resource_record_post_action 15:19:14 INFO - ##### 15:19:14 INFO - ##### Running download-and-extract step. 15:19:14 INFO - ##### 15:19:14 INFO - Running pre-action listener: _resource_record_pre_action 15:19:14 INFO - Running main action method: download_and_extract 15:19:14 INFO - mkdir: /builds/slave/test/build/tests 15:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:14 INFO - https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:19:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/test_packages.json 15:19:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/test_packages.json 15:19:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:19:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:19:17 INFO - Downloaded 1448 bytes. 15:19:17 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:19:17 INFO - Using the following test package requirements: 15:19:17 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:19:17 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:19:17 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:19:17 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:17 INFO - u'jsshell-linux-x86_64.zip'], 15:19:17 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:19:17 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:19:17 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:19:17 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:19:17 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:19:17 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:19:17 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:19:17 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:19:17 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')]} 15:19:17 INFO - https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:19:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:19:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:19:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/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 15:19:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/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 15:19:19 INFO - Downloaded 21172379 bytes. 15:19:19 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'] 15:19:19 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 15:19:20 INFO - Return code: 0 15:19:20 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 15:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:20 INFO - https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:19:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:19:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:19:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/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 15:19:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/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 15:19:22 INFO - Downloaded 21172379 bytes. 15:19:22 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'] 15:19:22 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 15:19:24 INFO - Return code: 0 15:19:24 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')]} 15:19:24 INFO - https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:19:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:19:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:19:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/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 15:19:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/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 15:19:25 INFO - Downloaded 11132144 bytes. 15:19:25 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'] 15:19:25 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 15:19:26 INFO - Return code: 0 15:19: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')]} 15:19:26 INFO - https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:19:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:19:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:19:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/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 15:19:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dxue3fXLRASJg-5W3PYB5Q/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 15:19:28 INFO - Downloaded 54127596 bytes. 15:19:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:19:28 INFO - mkdir: /builds/slave/test/properties 15:19:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:19:28 INFO - Writing to file /builds/slave/test/properties/build_url 15:19:28 INFO - Contents: 15:19:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:19:28 INFO - Running post-action listener: _resource_record_post_action 15:19:28 INFO - Running post-action listener: set_extra_try_arguments 15:19:28 INFO - ##### 15:19:28 INFO - ##### Running populate-webroot step. 15:19:28 INFO - ##### 15:19:28 INFO - Running pre-action listener: _resource_record_pre_action 15:19:28 INFO - Running main action method: populate_webroot 15:19:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:19:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:19:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:19:28 INFO - '--tppagecycles', 15:19:28 INFO - '7'], 15:19:28 INFO - 'tests': ['tsvgm']}}, 15:19:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:19:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:19:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:19:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:19:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:19:28 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:19:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:28 INFO - 'talos_options': ['--e10s'], 15:19:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:28 INFO - 'tests': ['damp', 'tps']}, 15:19:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:28 INFO - 'talos_options': ['--e10s'], 15:19:28 INFO - 'tests': ['damp', 'tps']}, 15:19:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:19:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:19:28 INFO - 'other': {'tests': ['a11yr', 15:19:28 INFO - 'ts_paint', 15:19:28 INFO - 'tpaint', 15:19:28 INFO - 'sessionrestore', 15:19:28 INFO - 'sessionrestore_no_auto_restore']}, 15:19:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:19:28 INFO - 'tests': ['a11yr', 15:19:28 INFO - 'ts_paint', 15:19:28 INFO - 'tpaint', 15:19:28 INFO - 'sessionrestore', 15:19:28 INFO - 'sessionrestore_no_auto_restore']}, 15:19:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:19:28 INFO - 'tests': ['a11yr', 15:19:28 INFO - 'ts_paint', 15:19:28 INFO - 'tpaint', 15:19:28 INFO - 'sessionrestore', 15:19:28 INFO - 'sessionrestore_no_auto_restore']}, 15:19:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:19:28 INFO - 'tests': ['a11yr', 15:19:28 INFO - 'ts_paint', 15:19:28 INFO - 'tpaint', 15:19:28 INFO - 'sessionrestore', 15:19:28 INFO - 'sessionrestore_no_auto_restore']}, 15:19:28 INFO - 'other_l64': {'tests': ['a11yr', 15:19:28 INFO - 'ts_paint', 15:19:28 INFO - 'tpaint', 15:19:28 INFO - 'sessionrestore', 15:19:28 INFO - 'sessionrestore_no_auto_restore']}, 15:19:28 INFO - 'other_nol64': {'tests': ['a11yr', 15:19:28 INFO - 'ts_paint', 15:19:28 INFO - 'tpaint', 15:19:28 INFO - 'sessionrestore', 15:19:28 INFO - 'sessionrestore_no_auto_restore']}, 15:19:28 INFO - 'svgr': {'tests': ['tsvgx', 15:19:28 INFO - 'tsvgr_opacity', 15:19:28 INFO - 'tart', 15:19:28 INFO - 'tscrollx', 15:19:28 INFO - 'cart']}, 15:19:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:19:28 INFO - 'tests': ['tsvgx', 15:19:28 INFO - 'tsvgr_opacity', 15:19:28 INFO - 'tart', 15:19:28 INFO - 'tscrollx', 15:19:28 INFO - 'cart']}, 15:19:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:28 INFO - 'tests': ['tp5o']}, 15:19:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:28 INFO - 'talos_options': ['--e10s'], 15:19:28 INFO - 'tests': ['tp5o']}, 15:19:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:28 INFO - 'talos_options': ['--xperf_path', 15:19:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:28 INFO - 'tests': ['tp5n']}, 15:19:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:28 INFO - 'talos_options': ['--e10s', 15:19:28 INFO - '--xperf_path', 15:19:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:28 INFO - 'tests': ['tp5n']}}, 15:19:28 INFO - 'talos.zip': {'path': '', 15:19:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:19:28 INFO - Running post-action listener: _resource_record_post_action 15:19:28 INFO - ##### 15:19:28 INFO - ##### Running create-virtualenv step. 15:19:28 INFO - ##### 15:19:28 INFO - Running pre-action listener: _resource_record_pre_action 15:19:28 INFO - Running main action method: create_virtualenv 15:19:28 INFO - Creating virtualenv /builds/slave/test/build/venv 15:19:28 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 15:19:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:19:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:19:28 INFO - Using real prefix '/usr' 15:19:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:19:29 INFO - Installing distribute.............................................................................................................................................................................................done. 15:19:31 INFO - Installing pip.................done. 15:19:31 INFO - Return code: 0 15:19:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:31 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 0x7ff89dcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c3d0>, '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 0x2a87ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a88360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', '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 15:19:31 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 15:19:31 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 15:19:31 INFO - Using env: {'DISPLAY': ':0', 15:19:31 INFO - 'HOME': '/home/cltbld', 15:19:31 INFO - 'LANG': 'en_US.UTF-8', 15:19:31 INFO - 'LANGUAGE': 'en_US:en', 15:19:31 INFO - 'LOGNAME': 'cltbld', 15:19:31 INFO - 'MAIL': '/var/mail/cltbld', 15:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:31 INFO - 'MOZ_NO_REMOTE': '1', 15:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:31 INFO - 'NO_EM_RESTART': '1', 15:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:31 INFO - 'PWD': '/builds/slave/test', 15:19:31 INFO - 'SHELL': '/bin/bash', 15:19:31 INFO - 'SHLVL': '1', 15:19:31 INFO - 'TERM': 'linux', 15:19:31 INFO - 'TMOUT': '86400', 15:19:31 INFO - 'USER': 'cltbld', 15:19:31 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', 15:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:31 INFO - '_': '/tools/buildbot/bin/python'} 15:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:31 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 15:19:31 INFO - Cleaning up... 15:19:31 INFO - Return code: 0 15:19:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:31 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 0x7ff89dcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c3d0>, '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 0x2a87ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a88360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', '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 15:19:31 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 15:19:31 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 15:19:31 INFO - Using env: {'DISPLAY': ':0', 15:19:31 INFO - 'HOME': '/home/cltbld', 15:19:31 INFO - 'LANG': 'en_US.UTF-8', 15:19:31 INFO - 'LANGUAGE': 'en_US:en', 15:19:31 INFO - 'LOGNAME': 'cltbld', 15:19:31 INFO - 'MAIL': '/var/mail/cltbld', 15:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:31 INFO - 'MOZ_NO_REMOTE': '1', 15:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:31 INFO - 'NO_EM_RESTART': '1', 15:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:31 INFO - 'PWD': '/builds/slave/test', 15:19:31 INFO - 'SHELL': '/bin/bash', 15:19:31 INFO - 'SHLVL': '1', 15:19:31 INFO - 'TERM': 'linux', 15:19:31 INFO - 'TMOUT': '86400', 15:19:31 INFO - 'USER': 'cltbld', 15:19:31 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', 15:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:31 INFO - '_': '/tools/buildbot/bin/python'} 15:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:31 INFO - Downloading/unpacking psutil>=0.7.1 15:19:31 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 15:19:31 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 15:19:31 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 15:19:31 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 15:19:31 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 15:19:31 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 15:19:33 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:19:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:19:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:33 INFO - Installing collected packages: psutil 15:19:33 INFO - Running setup.py install for psutil 15:19:33 INFO - building 'psutil._psutil_linux' extension 15:19:33 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 15:19:33 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 15:19:33 INFO - building 'psutil._psutil_posix' extension 15:19:33 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 15:19:34 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 15:19:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:34 INFO - Successfully installed psutil 15:19:34 INFO - Cleaning up... 15:19:34 INFO - Return code: 0 15:19:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:34 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 0x7ff89dcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c3d0>, '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 0x2a87ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a88360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', '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 15:19:34 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 15:19:34 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 15:19:34 INFO - Using env: {'DISPLAY': ':0', 15:19:34 INFO - 'HOME': '/home/cltbld', 15:19:34 INFO - 'LANG': 'en_US.UTF-8', 15:19:34 INFO - 'LANGUAGE': 'en_US:en', 15:19:34 INFO - 'LOGNAME': 'cltbld', 15:19:34 INFO - 'MAIL': '/var/mail/cltbld', 15:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:34 INFO - 'MOZ_NO_REMOTE': '1', 15:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:34 INFO - 'NO_EM_RESTART': '1', 15:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:34 INFO - 'PWD': '/builds/slave/test', 15:19:34 INFO - 'SHELL': '/bin/bash', 15:19:34 INFO - 'SHLVL': '1', 15:19:34 INFO - 'TERM': 'linux', 15:19:34 INFO - 'TMOUT': '86400', 15:19:34 INFO - 'USER': 'cltbld', 15:19:34 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', 15:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:34 INFO - '_': '/tools/buildbot/bin/python'} 15:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:19:34 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 15:19:34 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 15:19:34 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 15:19:34 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 15:19:34 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 15:19:34 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 15:19:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:19:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:19:36 INFO - Installing collected packages: mozsystemmonitor 15:19:36 INFO - Running setup.py install for mozsystemmonitor 15:19:36 INFO - Successfully installed mozsystemmonitor 15:19:36 INFO - Cleaning up... 15:19:36 INFO - Return code: 0 15:19:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:19:36 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')]} 15:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:36 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')]} 15:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:36 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 0x7ff89dcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c3d0>, '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 0x2a87ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a88360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', '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 15:19:36 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 15:19:36 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 15:19:36 INFO - Using env: {'DISPLAY': ':0', 15:19:36 INFO - 'HOME': '/home/cltbld', 15:19:36 INFO - 'LANG': 'en_US.UTF-8', 15:19:36 INFO - 'LANGUAGE': 'en_US:en', 15:19:36 INFO - 'LOGNAME': 'cltbld', 15:19:36 INFO - 'MAIL': '/var/mail/cltbld', 15:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:36 INFO - 'MOZ_NO_REMOTE': '1', 15:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:36 INFO - 'NO_EM_RESTART': '1', 15:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:36 INFO - 'PWD': '/builds/slave/test', 15:19:36 INFO - 'SHELL': '/bin/bash', 15:19:36 INFO - 'SHLVL': '1', 15:19:36 INFO - 'TERM': 'linux', 15:19:36 INFO - 'TMOUT': '86400', 15:19:36 INFO - 'USER': 'cltbld', 15:19:36 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', 15:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:36 INFO - '_': '/tools/buildbot/bin/python'} 15:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:36 INFO - Downloading/unpacking blobuploader==1.2.4 15:19:36 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 15:19:36 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 15:19:36 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 15:19:36 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 15:19:36 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 15:19:36 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 15:19:38 INFO - Downloading blobuploader-1.2.4.tar.gz 15:19:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:19:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:19:38 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 15:19:38 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 15:19:38 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 15:19:38 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 15:19:38 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 15:19:38 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 15:19:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:19:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:19:38 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 15:19:38 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 15:19:38 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 15:19:38 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 15:19:38 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 15:19:38 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 15:19:38 INFO - Downloading docopt-0.6.1.tar.gz 15:19:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:19:39 INFO - Installing collected packages: blobuploader, requests, docopt 15:19:39 INFO - Running setup.py install for blobuploader 15:19:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:19:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:19:39 INFO - Running setup.py install for requests 15:19:39 INFO - Running setup.py install for docopt 15:19:39 INFO - Successfully installed blobuploader requests docopt 15:19:39 INFO - Cleaning up... 15:19:39 INFO - Return code: 0 15:19:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:39 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 0x7ff89dcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c3d0>, '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 0x2a87ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a88360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', '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 15:19:39 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 15:19:39 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 15:19:39 INFO - Using env: {'DISPLAY': ':0', 15:19:39 INFO - 'HOME': '/home/cltbld', 15:19:39 INFO - 'LANG': 'en_US.UTF-8', 15:19:39 INFO - 'LANGUAGE': 'en_US:en', 15:19:39 INFO - 'LOGNAME': 'cltbld', 15:19:39 INFO - 'MAIL': '/var/mail/cltbld', 15:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:39 INFO - 'MOZ_NO_REMOTE': '1', 15:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:39 INFO - 'NO_EM_RESTART': '1', 15:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:39 INFO - 'PWD': '/builds/slave/test', 15:19:39 INFO - 'SHELL': '/bin/bash', 15:19:39 INFO - 'SHLVL': '1', 15:19:39 INFO - 'TERM': 'linux', 15:19:39 INFO - 'TMOUT': '86400', 15:19:39 INFO - 'USER': 'cltbld', 15:19:39 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', 15:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:39 INFO - '_': '/tools/buildbot/bin/python'} 15:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:39 INFO - Running setup.py (path:/tmp/pip-xHS7Af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:39 INFO - Running setup.py (path:/tmp/pip-aMz54S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:39 INFO - Running setup.py (path:/tmp/pip-cwCHLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:40 INFO - Running setup.py (path:/tmp/pip-MOHBC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:40 INFO - Running setup.py (path:/tmp/pip-Nwr8Fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:40 INFO - Running setup.py (path:/tmp/pip-SicPcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:40 INFO - Running setup.py (path:/tmp/pip-ILC5XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:40 INFO - Running setup.py (path:/tmp/pip-sPnQAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:40 INFO - Running setup.py (path:/tmp/pip-n_kqFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:40 INFO - Running setup.py (path:/tmp/pip-DF5b0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:40 INFO - Running setup.py (path:/tmp/pip-0XBU4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:40 INFO - Running setup.py (path:/tmp/pip-LRJHPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:40 INFO - Running setup.py (path:/tmp/pip-t93ord-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:40 INFO - Running setup.py (path:/tmp/pip-W1Xynl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:40 INFO - Running setup.py (path:/tmp/pip-_Th0vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:40 INFO - Running setup.py (path:/tmp/pip-lfWMFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:40 INFO - Running setup.py (path:/tmp/pip-jTJExH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:19:41 INFO - Running setup.py install for manifestparser 15:19:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:19:41 INFO - Running setup.py install for mozcrash 15:19:41 INFO - Running setup.py install for mozdebug 15:19:41 INFO - Running setup.py install for mozdevice 15:19:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:19:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:19:41 INFO - Running setup.py install for mozfile 15:19:41 INFO - Running setup.py install for mozhttpd 15:19:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:19:41 INFO - Running setup.py install for mozinfo 15:19:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:19:41 INFO - Running setup.py install for mozInstall 15:19:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:19:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:19:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:19:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:19:41 INFO - Running setup.py install for mozleak 15:19:41 INFO - Running setup.py install for mozlog 15:19:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:19:42 INFO - Running setup.py install for moznetwork 15:19:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:19:42 INFO - Running setup.py install for mozprocess 15:19:42 INFO - Running setup.py install for mozprofile 15:19:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:19:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:19:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:19:42 INFO - Running setup.py install for mozrunner 15:19:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:19:42 INFO - Running setup.py install for mozscreenshot 15:19:42 INFO - Running setup.py install for moztest 15:19:42 INFO - Running setup.py install for mozversion 15:19:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:19:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:19:42 INFO - Cleaning up... 15:19:42 INFO - Return code: 0 15:19:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ff89dcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c3d0>, '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 0x2a87ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a88360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', '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 15:19:42 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 15:19:42 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 15:19:42 INFO - Using env: {'DISPLAY': ':0', 15:19:42 INFO - 'HOME': '/home/cltbld', 15:19:42 INFO - 'LANG': 'en_US.UTF-8', 15:19:42 INFO - 'LANGUAGE': 'en_US:en', 15:19:42 INFO - 'LOGNAME': 'cltbld', 15:19:42 INFO - 'MAIL': '/var/mail/cltbld', 15:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:42 INFO - 'MOZ_NO_REMOTE': '1', 15:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:42 INFO - 'NO_EM_RESTART': '1', 15:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:42 INFO - 'PWD': '/builds/slave/test', 15:19:42 INFO - 'SHELL': '/bin/bash', 15:19:42 INFO - 'SHLVL': '1', 15:19:42 INFO - 'TERM': 'linux', 15:19:42 INFO - 'TMOUT': '86400', 15:19:42 INFO - 'USER': 'cltbld', 15:19:42 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', 15:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:42 INFO - '_': '/tools/buildbot/bin/python'} 15:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:43 INFO - Running setup.py (path:/tmp/pip-9ijGRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:43 INFO - Running setup.py (path:/tmp/pip-8Y3ppf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:43 INFO - Running setup.py (path:/tmp/pip-yjxMYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:43 INFO - Running setup.py (path:/tmp/pip-s0c5dK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:43 INFO - Running setup.py (path:/tmp/pip-8oiGsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:43 INFO - Running setup.py (path:/tmp/pip-SOSc6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:43 INFO - Running setup.py (path:/tmp/pip-QAWn27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:43 INFO - Running setup.py (path:/tmp/pip-tDRByq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:43 INFO - Running setup.py (path:/tmp/pip-2BGDi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:43 INFO - Running setup.py (path:/tmp/pip-GL0ht2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:43 INFO - Running setup.py (path:/tmp/pip-RX78Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:43 INFO - Running setup.py (path:/tmp/pip-v_4p5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:43 INFO - Running setup.py (path:/tmp/pip-GMSV5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:43 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)) 15:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:43 INFO - Running setup.py (path:/tmp/pip-hwhdHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:44 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)) 15:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:44 INFO - Running setup.py (path:/tmp/pip-H6rdYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:44 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)) 15:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:44 INFO - Running setup.py (path:/tmp/pip-HjovSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:44 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)) 15:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:44 INFO - Running setup.py (path:/tmp/pip-griHu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:44 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)) 15:19:44 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)) 15:19:44 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)) 15:19:44 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)) 15:19:44 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)) 15:19:44 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)) 15:19:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:45 INFO - Downloading blessings-1.5.1.tar.gz 15:19:45 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 15:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:19:46 INFO - Installing collected packages: blessings 15:19:46 INFO - Running setup.py install for blessings 15:19:46 INFO - Successfully installed blessings 15:19:46 INFO - Cleaning up... 15:19:46 INFO - Return code: 0 15:19:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:19:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:46 INFO - Reading from file tmpfile_stdout 15:19:46 INFO - Current package versions: 15:19:46 INFO - argparse == 1.2.1 15:19:46 INFO - blessings == 1.5.1 15:19:46 INFO - blobuploader == 1.2.4 15:19:46 INFO - docopt == 0.6.1 15:19:46 INFO - manifestparser == 1.1 15:19:46 INFO - mozInstall == 1.12 15:19:46 INFO - mozcrash == 0.16 15:19:46 INFO - mozdebug == 0.1 15:19:46 INFO - mozdevice == 0.48 15:19:46 INFO - mozfile == 1.2 15:19:46 INFO - mozhttpd == 0.7 15:19:46 INFO - mozinfo == 0.9 15:19:46 INFO - mozleak == 0.1 15:19:46 INFO - mozlog == 3.1 15:19:46 INFO - moznetwork == 0.27 15:19:46 INFO - mozprocess == 0.22 15:19:46 INFO - mozprofile == 0.28 15:19:46 INFO - mozrunner == 6.11 15:19:46 INFO - mozscreenshot == 0.1 15:19:46 INFO - mozsystemmonitor == 0.0 15:19:46 INFO - moztest == 0.7 15:19:46 INFO - mozversion == 1.4 15:19:46 INFO - psutil == 3.1.1 15:19:46 INFO - requests == 1.2.3 15:19:46 INFO - wsgiref == 0.1.2 15:19:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:46 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')]} 15:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:46 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')]} 15:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:46 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 0x7ff89dcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c3d0>, '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 0x2a87ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a88360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', '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 15:19:46 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 15:19:46 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 15:19:46 INFO - Using env: {'DISPLAY': ':0', 15:19:46 INFO - 'HOME': '/home/cltbld', 15:19:46 INFO - 'LANG': 'en_US.UTF-8', 15:19:46 INFO - 'LANGUAGE': 'en_US:en', 15:19:46 INFO - 'LOGNAME': 'cltbld', 15:19:46 INFO - 'MAIL': '/var/mail/cltbld', 15:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:46 INFO - 'MOZ_NO_REMOTE': '1', 15:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:46 INFO - 'NO_EM_RESTART': '1', 15:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:46 INFO - 'PWD': '/builds/slave/test', 15:19:46 INFO - 'SHELL': '/bin/bash', 15:19:46 INFO - 'SHLVL': '1', 15:19:46 INFO - 'TERM': 'linux', 15:19:46 INFO - 'TMOUT': '86400', 15:19:46 INFO - 'USER': 'cltbld', 15:19:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', 15:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:46 INFO - '_': '/tools/buildbot/bin/python'} 15:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:46 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)) 15:19:46 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)) 15:19:46 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)) 15:19:46 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)) 15:19:46 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)) 15:19:46 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)) 15:19:46 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)) 15:19:46 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)) 15:19:46 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)) 15:19:46 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)) 15:19:46 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)) 15:19:46 INFO - Cleaning up... 15:19:46 INFO - Return code: 0 15:19:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:19:46 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')]} 15:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:46 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')]} 15:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:46 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 0x7ff89dcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c3d0>, '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 0x2a87ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a88360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', '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 15:19:46 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 15:19:46 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 15:19:46 INFO - Using env: {'DISPLAY': ':0', 15:19:46 INFO - 'HOME': '/home/cltbld', 15:19:46 INFO - 'LANG': 'en_US.UTF-8', 15:19:46 INFO - 'LANGUAGE': 'en_US:en', 15:19:46 INFO - 'LOGNAME': 'cltbld', 15:19:46 INFO - 'MAIL': '/var/mail/cltbld', 15:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:46 INFO - 'MOZ_NO_REMOTE': '1', 15:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:46 INFO - 'NO_EM_RESTART': '1', 15:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:46 INFO - 'PWD': '/builds/slave/test', 15:19:46 INFO - 'SHELL': '/bin/bash', 15:19:46 INFO - 'SHLVL': '1', 15:19:46 INFO - 'TERM': 'linux', 15:19:46 INFO - 'TMOUT': '86400', 15:19:46 INFO - 'USER': 'cltbld', 15:19:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', 15:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:46 INFO - '_': '/tools/buildbot/bin/python'} 15:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:46 INFO - Downloading/unpacking jsonschema 15:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:19:48 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 15:19:48 INFO - Downloading/unpacking functools32 (from jsonschema) 15:19:48 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 15:19:48 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 15:19:48 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 15:19:48 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 15:19:48 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 15:19:48 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 15:19:48 INFO - Downloading functools32-3.2.3-2.tar.gz 15:19:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:19:48 INFO - warning: no files found matching '*.txt' 15:19:48 INFO - no previously-included directories found matching 'build' 15:19:48 INFO - no previously-included directories found matching 'dist' 15:19:48 INFO - no previously-included directories found matching '.git*' 15:19:48 INFO - Installing collected packages: jsonschema, functools32 15:19:48 INFO - Running setup.py install for functools32 15:19:48 INFO - warning: no files found matching '*.txt' 15:19:48 INFO - no previously-included directories found matching 'build' 15:19:48 INFO - no previously-included directories found matching 'dist' 15:19:48 INFO - no previously-included directories found matching '.git*' 15:19:48 INFO - Successfully installed jsonschema functools32 15:19:48 INFO - Cleaning up... 15:19:49 INFO - Return code: 0 15:19:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff89dcc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c3d0>, '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 0x2a87ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a88360>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', '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 15:19: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', 'flake8'] in /builds/slave/test/build 15:19: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 flake8 15:19:49 INFO - Using env: {'DISPLAY': ':0', 15:19:49 INFO - 'HOME': '/home/cltbld', 15:19:49 INFO - 'LANG': 'en_US.UTF-8', 15:19:49 INFO - 'LANGUAGE': 'en_US:en', 15:19:49 INFO - 'LOGNAME': 'cltbld', 15:19:49 INFO - 'MAIL': '/var/mail/cltbld', 15:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:49 INFO - 'MOZ_NO_REMOTE': '1', 15:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:49 INFO - 'NO_EM_RESTART': '1', 15:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:49 INFO - 'PWD': '/builds/slave/test', 15:19:49 INFO - 'SHELL': '/bin/bash', 15:19:49 INFO - 'SHLVL': '1', 15:19:49 INFO - 'TERM': 'linux', 15:19:49 INFO - 'TMOUT': '86400', 15:19:49 INFO - 'USER': 'cltbld', 15:19:49 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', 15:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:49 INFO - '_': '/tools/buildbot/bin/python'} 15:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:49 INFO - Downloading/unpacking flake8 15:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:19:50 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 15:19:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:19:51 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 15:19:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:19:51 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 15:19:51 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 15:19:51 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 15:19:51 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 15:19:51 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 15:19:51 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 15:19:51 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 15:19:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:19:51 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 15:19:51 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 15:19:51 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 15:19:51 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 15:19:51 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 15:19:51 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 15:19:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:19:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:19:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:19:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:19:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:19:51 INFO - no previously-included directories found matching 'docs/_build' 15:19:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:19:51 INFO - Running setup.py install for pep8 15:19:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:19:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:19:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:19:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:19:51 INFO - no previously-included directories found matching 'docs/_build' 15:19:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:19:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:19:51 INFO - Cleaning up... 15:19:51 INFO - Return code: 0 15:19:51 INFO - Running post-action listener: _resource_record_post_action 15:19:51 INFO - Running post-action listener: _start_resource_monitoring 15:19:51 INFO - Starting resource monitoring. 15:19:51 INFO - ##### 15:19:51 INFO - ##### Running install step. 15:19:51 INFO - ##### 15:19:51 INFO - Running pre-action listener: _resource_record_pre_action 15:19:51 INFO - Running main action method: install 15:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:52 INFO - Reading from file tmpfile_stdout 15:19:52 INFO - Detecting whether we're running mozinstall >=1.0... 15:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:19:52 INFO - Reading from file tmpfile_stdout 15:19:52 INFO - Output received: 15:19:52 INFO - Usage: mozinstall [options] installer 15:19:52 INFO - Options: 15:19:52 INFO - -h, --help show this help message and exit 15:19:52 INFO - -d DEST, --destination=DEST 15:19:52 INFO - Directory to install application into. [default: 15:19:52 INFO - "/builds/slave/test"] 15:19:52 INFO - --app=APP Application being installed. [default: firefox] 15:19:52 INFO - mkdir: /builds/slave/test/build/application 15:19:52 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'] 15:19:52 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 15:20:07 INFO - Reading from file tmpfile_stdout 15:20:07 INFO - Output received: 15:20:07 INFO - /builds/slave/test/build/application/firefox/firefox 15:20:07 INFO - Running post-action listener: _resource_record_post_action 15:20:07 INFO - ##### 15:20:07 INFO - ##### Running run-tests step. 15:20:07 INFO - ##### 15:20:07 INFO - Running pre-action listener: _resource_record_pre_action 15:20:07 INFO - Running main action method: run_tests 15:20:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:20:07 INFO - Python 2.7.3 15:20:07 INFO - Return code: 0 15:20:07 INFO - grabbing minidump binary from tooltool 15:20: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')]} 15:20:07 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 0x2b1c3d0>, '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 0x2a87ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a88360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:20:07 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 15:20:07 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 15:20:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:20:07 INFO - Return code: 0 15:20:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:20:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:20:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:20:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:20:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:20:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:20:08 INFO - Return code: 0 15:20:08 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:20:08 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:20:08 INFO - Using env: {'DISPLAY': ':0', 15:20:08 INFO - 'HOME': '/home/cltbld', 15:20:08 INFO - 'LANG': 'en_US.UTF-8', 15:20:08 INFO - 'LANGUAGE': 'en_US:en', 15:20:08 INFO - 'LOGNAME': 'cltbld', 15:20:08 INFO - 'MAIL': '/var/mail/cltbld', 15:20:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:20:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:08 INFO - 'MOZ_NO_REMOTE': '1', 15:20:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:08 INFO - 'NO_EM_RESTART': '1', 15:20:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:08 INFO - 'PWD': '/builds/slave/test', 15:20:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:20:08 INFO - 'SHELL': '/bin/bash', 15:20:08 INFO - 'SHLVL': '1', 15:20:08 INFO - 'TERM': 'linux', 15:20:08 INFO - 'TMOUT': '86400', 15:20:08 INFO - 'USER': 'cltbld', 15:20:08 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520', 15:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:08 INFO - '_': '/tools/buildbot/bin/python'} 15:20:08 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:20:09 INFO - mozversion application_buildid: 20160115145423 15:20:09 INFO - mozversion application_changeset: 71dec72dcdd5a2318328cf74c22a4f8c967fbe2c 15:20:09 INFO - mozversion application_display_name: Nightly 15:20:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:20:09 INFO - mozversion application_name: Firefox 15:20:09 INFO - mozversion application_remotingname: firefox 15:20:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:20:09 INFO - mozversion application_vendor: Mozilla 15:20:09 INFO - mozversion application_version: 46.0a1 15:20:09 INFO - mozversion platform_buildid: 20160115145423 15:20:09 INFO - mozversion platform_changeset: 71dec72dcdd5a2318328cf74c22a4f8c967fbe2c 15:20:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:20:09 INFO - mozversion platform_version: 46.0a1 15:20:09 INFO - using testdate: 1452900009 15:20:09 INFO - actual date: 1452900009 15:20:09 INFO - starting webserver on 'localhost:44715' 15:20:09 INFO - SUITE-START | Running 3 tests 15:20:09 INFO - TEST-START | dromaeo_css 15:20:09 INFO - operating with platform_type : linux_ 15:20:09 INFO - Initialising browser for dromaeo_css test... 15:20:09 INFO - TEST-INFO | started process 12456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTaMlmJ/profile http://localhost:44715/getInfo.html) 15:20:13 INFO - PROCESS | 12456 | __metrics Screen width/height:1600/1200 15:20:13 INFO - PROCESS | 12456 | colorDepth:24 15:20:13 INFO - PROCESS | 12456 | Browser inner width/height: 1024/697 15:20:13 INFO - PROCESS | 12456 | __metrics 15:20:14 INFO - PROCESS | 12456 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:20:14 INFO - PROCESS | 12456 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:20:15 INFO - TEST-INFO | 12456: exit 0 15:20:15 INFO - Browser initialized. 15:20:15 INFO - Running cycle 1/1 for dromaeo_css test... 15:20:15 INFO - TEST-INFO | started process 12547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTaMlmJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:27 INFO - PROCESS | 12547 | RSS: Main: 149741568 15:20:27 INFO - PROCESS | 12547 | 15:21:17 INFO - PROCESS | 12547 | 1452900077993 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] 15:23:29 INFO - PROCESS | 12547 | Cycle 1(1): loaded http://localhost:44715/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44715/tests/dromaeo/cssquery-ext.html) 15:23:30 INFO - PROCESS | 12547 | RSS: Main: 259457024 15:23:30 INFO - PROCESS | 12547 | 15:26:33 INFO - PROCESS | 12547 | Cycle 1(1): loaded http://localhost:44715/tests/dromaeo/cssquery-ext.html (next: http://localhost:44715/tests/dromaeo/cssquery-jquery.html) 15:26:33 INFO - PROCESS | 12547 | RSS: Main: 231620608 15:26:33 INFO - PROCESS | 12547 | 15:29:35 INFO - PROCESS | 12547 | Cycle 1(1): loaded http://localhost:44715/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44715/tests/dromaeo/cssquery-mootools.html) 15:29:36 INFO - PROCESS | 12547 | RSS: Main: 230223872 15:29:36 INFO - PROCESS | 12547 | 15:32:38 INFO - PROCESS | 12547 | Cycle 1(1): loaded http://localhost:44715/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44715/tests/dromaeo/cssquery-prototype.html) 15:32:39 INFO - PROCESS | 12547 | RSS: Main: 211427328 15:32:39 INFO - PROCESS | 12547 | 15:35:41 INFO - PROCESS | 12547 | Cycle 1(1): loaded http://localhost:44715/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44715/tests/dromaeo/cssquery-yui.html) 15:35:42 INFO - PROCESS | 12547 | RSS: Main: 216358912 15:35:42 INFO - PROCESS | 12547 | 15:38:45 INFO - PROCESS | 12547 | Cycle 1(1): loaded http://localhost:44715/tests/dromaeo/cssquery-yui.html (next: http://localhost:44715/tests/dromaeo/cssquery-dojo.html) 15:38:45 INFO - PROCESS | 12547 | RSS: Main: 229031936 15:38:45 INFO - PROCESS | 12547 | 15:38:45 INFO - PROCESS | 12547 | __start_tp_report 15:38:45 INFO - PROCESS | 12547 | _x_x_mozilla_page_load 15:38:45 INFO - PROCESS | 12547 | _x_x_mozilla_page_load_details 15:38:45 INFO - PROCESS | 12547 | |i|pagename|runs| 15:38:45 INFO - PROCESS | 12547 | |0;dojo.html;2545.274596739929;2580.045383208213;2603.6485074514935;2617.489589530041;2624.855632940188;4320.546342634026;4395.560443955603;4418.337249412586;4422.071365013347;4471.083427897282;4371.388005679208;4432.822687092521;4459.397981272527;4471.754053527055;4476.910461790762;4100.979495102535;4119.0937993641355;4119.361498967664;4132.855350062733;4156.729812562189;3924.9018774530578;4180.24755544002;4200.390943313218;4220.451341325639;4256.659467242614;4019.778912159845;4086.5504794472586;4089.488813898263;4094.7747873866924;4161.0845613964875;4134.400511925784;4146.4402305688645;4146.502419709624;4153.0447996960565;4181.979090104561;4108.116754897682;4112.218678451115;4124.731892426983;4154.729942553724;4163.437935878678;4292.098659281554;4353.673474489426;4362.127574485084;4371.803268852909;4384.671149663756;4697.906041879143;4714.693544919569;4719.032598317337;4747.6914000590195;4751.40607424072;4737.644676649265;4741.170295198326;4746.786394612251;4782.760861956888;4797.232442809169;4297.720648157829;4369.06065195978;4372.693911426233;4395.714278571946;4408.669349798778;4853.854384368475;4865.854024379274;4867.342908707279;4873.634477414137;4878.390201224847;4666.323383109498;4667.276572131325;4667.439907211156;4669.813207471731;4695.366125573072;4637.373954516164;4695;4707.435107787019;4712.057588482317;4785.545373189541;4693.601043911306;4699.465016259326;4715.905681886343;4727.078219747116;4752.334673145762;4669.95330046702;4673.509281525459;4674.158651442773;4676.976615116971;4715.4577223619035;3884.1843212925037;3953.881383558498;3955.3869150281753;3956.40653901917;3972.920541589152;3520.1727594015388;3523;3534.4698295255916;3536.964630353715;3544.0608238816217;4089.427480152781;4090.877273681794;4096.508418989681;4152.294110001307;4157.127003329274;4714.57568818808;4717.386739723814;4717.575418212377;4725.5510726480925;4770.403699537558;4070.287699652549;4071.4096456013713;4071.714979951375;4107.322291821875;4112.424260603518;4095.97952010244;4169.1661667666585;4190.958090419118;4200.978995105066;4213.367994800743;4491.416115904912;4500.617447516932;4507.323901414748;4537.1833070047705;4541.137183935041;4717.245240761462;4726.291056341576;4726.432828060655;4737.952620473889;4777.641676874317;4405.449318835145;4460.397846290709;4483.7533935633855;4493.550644935611;4498.347739577808;4625.444946606429;4639.652026098123;4649.907001860011;4657.69724967876;4695.835645752382;4749.525047495223;4750.928736068892;4751.358566593465;4752.097101550833;4795.352627395257;4504.504504504567;4570.88572785683;4574.679772415899;4627.9768601156775;4636.258198688193;4434.467863856358;4496.348029535634;4591.724496530219;4612.4926258112255;4629.097326021393;4500.662450316305;4516.345129956072;4536.070105628272;4539.432570928634;4575.862724118282;4471.463424389094;4546.909061818811;4553.9316910247035;4637.3739545162325;4649.372334734768;4472.530384309731;4495.25828238337;4508.413906192174;4536.274196128604;4555.817767289272 15:38:45 INFO - PROCESS | 12547 | |1;ext.html;487.81706859927505;501.4734528744817;508.56517677385835;519.9055987147054;532.7096732280907;23854.28437146886;24834.254972350835;24847.13035043774;24874;31972.68027319726;34865.82567087167;35429.82285088571;35454.645453545454;35458.822705886436;35461.64538354616;7560.584167870778;7753.069631644211;7759.680854254762;7764.534127952341;7765.844683106335;7524.586147761871;7687.615619219045;7687.846243075135;7688.461807673465;7695.268949449794;7602.885956710654;7939.36485081195;7941.880871786928;7945.245201705829;7952.165022672622;7769.844603107935;7892.763217103496;7893.052833659997;7899.249571290776;7902.920970790334;7557.093148822121;7711.151773304932;7713.730019449348;7715.112762032326;7722.11195712489;35261.47107793385;35779;35786.46320305197;35800.82099589486;35804.82097589495;2877.510823160047;3070.186400603842;3119.298157914474;3177.5998092247823;3346.2470944037395;26383.47233055347;26776;26941.057063002896;26951;27480.862595686893;3186.5379519969474;3229.790063645879;3234.7250483708913;3305.206750379916;3348.815815130167;196490;198400;199228.99999999854;199327;200212;45793.481358524936;47088.76455617769;51895.74052129791;52189;52194.47805521972;43707.78146109249;56821.43178568244;57955.710221449466;58034.419655803744;58046.41953580495;11465.713357166138;11623.59317423886;11626.418679066013;11658.883411165949;11687.298762074302;7380.96309518449;8716.738497845075;8842.778930526789;8843.513606751561;8865.290776737975;14933.25333733309;18529.53676158107;18628.72056919147;18742.1566029529;18792;7142.642867856586;7382;7406.592637404994;7435.40516758658;7631.618419079024;736.6390468670313;765.5215490318551;787.8266781308103;803.5580430763057;908.3414524469706;21705.34883953484;22515.437114071952;25165.24504264875;26366.209013729618;26401.207963761117;885.0927799005941;930.1582068228264;941.3457646935451;993.2252842782497;993.5876611206413;11680;13419.261940593362;13986.790198147037;14023.719525609635;14135.71728565423;259333;260263;260855;261296;263523;36960;36996.815015924745;37021.81489092537;37110;37127;1171.6133675886938;1178.0987544528443;1189.8036823924128;1189.9464524096436;1190.4047976012166;23114.53770924606;23389.76610233876;23701.762982370645;23769;23784.762152378255;38703.61296387;38946.2210755789;38961.805190973864;38986.80506597449;38992.415113772746;235025;236169;238395;238972;239692;23387.649185262577;23952.64071038901;26627.33431664224;27318;27351.86324068367;31878.52182217315;32088.35823283568;32407.51388729218;32472.512912306807;32748.83625581857;28170.718292816808;29840.850795745882;31005.379892401575;34835.47746783851;35170.64829351776;28083.578746319232;30199.69800301969;30404.087877363716;30654.540181897737;31474.685253147174;28368.148955531367;28714.85642571774;36247.45628815622;36533.269334612625;36745.63254367422;30436.847815761666;31367.686323136477;31411.685883140875;31759.682403175673;31788;25234;25626.103086391886;25887.611685825104;25922.22233333003;25938.22185334443 15:38:45 INFO - PROCESS | 12547 | |2;jquery.html;340.0648217402144;340.62190968025504;342.40592571887777;343.23116219667946;345.3266131044464;11602.767944641102;12154.513819447233;13566.660833479156;13869.791953120699;15459.536213913601;13872.861271387283;14256.215908125048;14365.066270692398;14993.85006149938;15009.849901500982;4821.90356192876;4872.440818937941;5045.697258164503;5047.67190132642;5087.160618497944;3652.0322114639644;3826.5408151021916;5511.421300763423;5743.597948143632;5751.4248575142365;5502.5597952163935;5658.0381335172915;5684.8294551163535;5709.0580054290995;5738.6556806591525;5610.07433773429;5644.8306550803545;5648.039833228361;5649.943500564983;5656.632318899258;4841.2496063110275;5030.245463180516;5045.672031317952;5050.545450909436;5057.342545469065;16840.831591684047;17587.648247034987;17751.822481775147;17989.370372036916;18056.097195140323;1651.7357222844407;1828.1590468384427;1885.7359969604267;2131.2860191835753;2197.1760589778833;7993.360531157494;8237.876431853527;8309.8338033239;8313.08556058833;10365.429901355423;1670.9081000544966;1747.6766798142385;1753.0883940351073;1761.0842361971702;1776.351631654437;48399.75800120977;48547.757261213825;49007.264891026665;49036.75481622605;49195.75402123002;9170.541472926327;9185.862212066824;9244.491552964517;9319.394239374418;9358.204552613104;11708.473118709679;11710;11711.1802173847;11723.941380293043;11769.058475321954;6050.394960503914;6200.3799620038535;6251.281102673251;6342.175517182829;6346.397092276226;5848.298204215522;5953.315368732565;6021.277446706424;6036.939630603725;6048.425399587032;3504.2465869838106;3695.9630403696156;3756.154865155318;3892.4355968384425;4014.9197016059516;1581.3437423469131;1653.2725600735637;1669.8998060116432;1693.9576510587333;1706.8634509239232;780.1223623423648;839.4375768235298;855.1405837133641;864.1833467373272;884.4428010353436;13620.727585448236;13752.65618359529;13944.093633913762;13950.720985580232;14017.649558761113;693.5665209244222;770.9807254818675;814.5764202614607;842.1872892658614;879.3053487744738;7364.3003914628025;7490.887636685454;7710.845783084307;7812.726554570563;7942.3646108311195;391751;397019;398289;405359;406636;47184;58735.41264587385;59013;59276.703616482504;59588.40411595915;956.5217391304348;972.7130496503548;981.087588542648;983.7589790501373;987.2003677021636;12922.676933076747;13004.024698147867;13413.32933353348;13430.0598958072;13463.05758596928;29383.412331753672;29449.852750736965;29588;29589.408211836075;30187.547186792654;37610.62389376071;38630;39170.2165956685;41345;43303.78348108239;7541.283578060075;7982.680692772224;8158.265756081981;8368.748937531884;8579.184977427134;9196.678116265899;9304.674336398193;9493.66772162971;9515.191208747334;9691.854622180814;6193.628382297076;6284.08880712285;6323.841903952254;6400.647964362005;6453;5925.555583331181;6338.651374174465;6354.872902541831;6424.036394540856;6524.347565243438;5961.850953726192;6030.276366836008;6346.333634968447;6464.127342808849;6505.7072431741635;8236.876446853423;8312.293455056146;8317.792055198668;8385.077641459313;8442.873356899529;6955.582665040114;8273.917260827315;8295.170482951899;8328.250457458858;8376.664933402595 15:38:45 INFO - PROCESS | 12547 | |3;mootools.html;1155.4396117882825;1156.4449064449063;1188.8097904335305;1239.5289789879844;1565.6242501799563;6171.074338849169;6498.447631951284;6630.03864439656;6647.867042659156;6667.899981500282;6806;6961.060256865334;6963.0251764752975;6966.094407727001;6970.895436568456;1738.521906475723;1792.5877048278903;2007.9397618071482;2047.4778931372516;2081.1779347157863;2074.3569493457076;2088.049937278535;2088.822450091744;2089.853710240284;2091.6130515854616;1988.2742798878378;1989.512569420494;2052.9794702052936;2053.37372101509;2053.537953960362;2004.7894971028124;2032.9695054574192;2035.5114772454651;2048.8053634904736;2050.282401159582;2027.8377729781582;2045.4068320187127;2045.6420126477806;2046.3451695457459;2046.4270004398793;6629.403353698142;6666.333366663343;6669.733210671568;6673.766418175341;6675.165604299463;3880.3597406427907;3985.920281594381;3991.1219531702977;4008.0581063450068;4009;2545.350935511451;2652.2971412575685;2658.827176233558;2663.9600405993924;2677.3306673331667;781.4217479065508;802.4904185841974;818.4925346285341;850.1668365002332;864.9091845356273;9245.72262832116;9265.397749146352;9280.675176368863;9292.256619470427;9301.674441394518;3629.256002519477;3717.0893131183034;3719.479272901796;3729.6083911189476;3772.773633581994;7945.880811787828;7946;7955.8408831823035;7960.761177164694;7966.7609971699785;3922.941155882664;3936.389859571771;3948.664363529132;3960.881173564798;3972.64246217836;3604.873829415958;3605.0626837022564;3608.657177568127;3608.891733248007;3612.1872578670113;2928.1361998210577;2979.3445442002726;3193.1697758582472;3205.3108581655056;3273.263515708994;1006.7030226083323;1008.8436292374547;1010.7018429563296;1031.7111208861531;1032.210359075308;836.5440834745078;837.9287760540423;839.5298632765671;840.8570543007703;1028.6348346336943;6482.157319548429;6496.285408605049;6513.804585862432;6542.084108224853;6548.345165483509;974.4883935933692;994.2841154368988;997.7006897930737;1003.7841863999275;1013.0932815130565;4764.785584648699;4798.4001999750035;4875.414950205927;4876.341693871353;4877.048975449753;8013.078495973038;8221.260086592116;8229.094799572042;8251.752447426587;8258.710945116893;7993.280604745601;8102.108768035511;8155.673773049011;8191.344692424592;8207.220314070153;6389.808305750835;6434.292227854932;6436.871262574722;6454.419102280817;6469.385408386196;5972.701364931823;5993.190919225849;6028.216331876828;6127.632342059491;6155.4767844731905;7311.488195826454;7419.258074192538;7442.255774422514;7466.664000120117;7497.512661676974;7366.594837284001;7529.284717951786;7531.811704707207;7682.539047657158;7707.499012564165;5750.482456578928;5803.82588522345;5805.303363596396;5806;5809.564282678901;5713.285839270091;5882.058870580687;6029.8191054268445;6225.595336303126;6242.406971337716;6247.219097612799;6313.810585682437;6370.649614271074;6384.3934826191435;6490.318516555693;5846.532277417881;5952.5237980960555;6006.099085137264;6045.818625441244;6055.364186760326;6097.634141951497;6110.450059494667;6140.263168419819;6247.718852651551;6253.812385628438;5737.282839645044;5785.652860828363;5787.074068149076;5791.449812267828;5796.971015144897;5879.412058794086;5881.176635271151;5926.170336153028;5929.555283353852;5931.13998470228 15:38:45 INFO - PROCESS | 12547 | |4;prototype.html;279.03315013478294;284.9031329348021;285.5702168236803;291.42879955287634;293.09579945866994;4919.680220785646;5084.38987321521;5277.70972596507;5290.947090529094;5314.256004159416;5141.511556402145;5276.604254680895;5305.575553955684;5305.734713264341;5313.1764576490705;4100.200460910124;4101.056756945904;4104.302268614335;4114.136031433388;4117.114820313632;3847.0574709196285;3948.5261768587666;3959.227950549644;4099.487564054493;4119.258533463975;3984.3425834737377;3991.161856010227;3993.480847489837;3994.720369574131;4000.6199411055904;4001.1997600479876;4012.7391719538136;4019.356902895537;4022.557518672973;4025.879223623296;3503.7722548034553;3506.526618906466;3507.3160733656946;3507.9824600877087;3509.5613048368955;5083.415407228142;5090.77091530882;5097.617678674077;5099.796008159669;5104.132297509395;4375.868723938287;4542.136993971135;4549.909001819979;4550.795214215368;4553.271476563734;5461.5357694596005;5502.697351645658;5503.587230957694;5506.311711036121;5514.80698175562;3441.105312618712;3534.717222622184;3593.94609080864;3708.0173753955223;3712.9071773205887;5723.599348045638;5774.422557744234;5791.536677065825;5794.536437085023;5825.737841797087;3787.3182827091387;3789.9431508527396;3790.5451345838123;3798.2023775007005;3801.8669346573292;3854.845806167722;3858.961410385916;3859.0159509324944;3866.0914685048992;3866.845326186977;4393.450818647669;4479.037007043501;4485.641148708096;4491.326301054803;4494.52807455219;5514.724263786875;5519.586031047687;5521.751521181556;5526;5531.170324451365;1339.7186590815843;1351.7837146056584;1355.830521184852;1355.8915286777035;1357.321339330335;897.1432282170512;897.2014906733012;902.6208992223281;922.0917396364575;925.2782829393084;4877.097736918681;4885.047415753894;4887.755612219375;4891;4892.804287828447;5756.683382414008;5758.942410575924;5759.107338362561;5761.971190144106;5777.653340799566;4892.877678058077;4895.363602731693;4899.804007839646;4902.583280421204;4903.436104847917;3008.7292143707173;3063.4945234036136;3104.161876293388;3106.6582675905634;3108.735757460596;5398.352197736297;5402.432744561843;5403;5433.891322173614;5449.237106805051;5865.178874957509;5908.793192238337;5909.793157239562;5912.142739302777;5920.141579470953;5434.592405569598;5450.727463626803;5452.5365343946205;5454;5456.127019676833;5641.5204707600315;5760;5833.212516310244;5837.970810145922;5838.649681019152;5374.892502150014;5672.744726487401;5673.347565030074;5678.801241956512;5681.801136960186;5306.257124002565;5338.012467693489;5485.286912701324;5501.504864562208;5505.752241149238;3812;3871.670907972854;3875.6705680016385;3876.806159691948;3878.26313000529;5792.362840087671;5793.681347525927;5798.159266906359;5805.448482394166;5809.419058094157;5376.838694839004;5549.916751248816;5582.302212223472;5590.413006634245;5597.188407680945;5603.32760068778;5604.747786349542;5670.5180059695385;5674.659520428788;5675.177099320493;5477.315335583052;5487.506124448819;5488.121900495901;5488.396276409512;5488.835334939959;5518.475744804237;5626.38109807929;5637.267155269788;5637.943620563742;5646.71766411686;5443.918341224964;5472.671639701472;5480.890382192254;5484.396716361117;5485.177223416519 15:38:45 INFO - PROCESS | 12547 | |5;yui.html;654.283559502345;667.6928612838095;672.2605134352211;704.8061783009668;709.3934685843607;10754.300970436925;10864.402457864815;10961.780764384708;10966;10968.17738669599;10919.344839309648;11007.889921100787;11017.614383496579;12230.266184028964;12476.251424914512;598.1207624791549;758.7761610324967;769.1731388757081;769.9576523291216;770.9421793365492;588.355750453253;588.5556404914283;590.2444870565662;605.2646035067393;662.6256165266633;792.188007292524;799.400449662753;799.7041094794934;799.7520768561735;800.6677228949978;623.7785586116931;630.7098734582098;778.5017588743209;792.7780221537979;792.8572856885759;586.8972929737322;587.2014060877203;588.0796553393925;588.1266319515516;588.814523425124;11530.654080377602;11550.59572914944;11584.536618535249;11589.94205028978;11634.069274458108;10718.356898586031;10997.780044399147;11178.04986576142;11271.661850144508;11550.768984620261;8827.99850541786;9113.179813816789;9157.908420915772;9201.309901757395;9365.531723413802;3131.170239886432;3136.4511210538294;3190.361927614463;3194.472911969522;3223.725983291423;39996.60003399958;40080;40321.59678403208;40326.798366008275;40385.39421908644;8615.181557752003;8797.956010220036;8857.512836794038;9024.819503610022;9027.729168124966;15606.609834753996;15611.141387223812;15632.296546655427;15655;15660.373585056697;6238.157848690459;6398.744050238031;6426.967865160737;6496.025596160519;6662.400383965466;3581.5164952731047;3595.9280814383565;3624.4200927851416;3651.8174091295327;3711.55461344635;2487.3035550046015;2507.210228777929;2507.4107584717576;2510.8367956082798;2513.924582262535;442.5264966485829;443.54093513214315;443.6716829546177;444.23147954039695;471.7429001194357;381.16144482139407;395.09326096607776;406.23019378277996;421.3700517725958;512.477273181353;7073.434125269966;7082.893756593655;7209.747658831916;7377.963110184414;8467;446.6583063956076;503.7733020140951;515.1448595331732;528.4372143666982;568.590614757374;3196.264859082424;3211.3577284542716;3231.6768323167494;3357.78174418662;3361.9495707564406;42915.141697165884;43153.35269970953;43191.35212971808;43282.78358608187;43462.91342716394;40996.59003409987;41287.58712412897;41311.1737765243;41609.58390416057;41800.581994179665;34138.48792268118;34715.65284347175;36645.083872902855;37433;37550;7519.849603008019;7664.233576642291;7876.173001834954;8037.156098609562;8180;28506.57240141441;28511.28721781889;28632.713672863003;28839.855800720863;28919.855400723703;33894;34210;35794.82102589471;35950.640493595776;35969.64030359768;9809.460479673686;9828.803423931624;9846.064623860722;9869.358491698016;9922.115973948883;10187.337823041478;10253.48732563354;10370.170386369224;10461.47692615351;10549.9472502637;9699.418034917646;9739.123478886933;9955;10025.147862431484;10567.577296908037;9500.382475139093;9598.088181622734;9642.758931026781;9720.07659272368;10080.647177348757;9750.804983900423;9966.152877005536;10010.199184065112;10141.898581014391;10144.949275253577;7964.482308649919;8142.7557173284895;8206;8360.958195208985;8482.024567174607;8379.622916968628;8908.465492070496;8930.285577153942;9012.504312262889;9190.678326258549 15:38:45 INFO - PROCESS | 12547 | __end_tp_report 15:38:45 INFO - PROCESS | 12547 | __start_cc_report 15:38:45 INFO - PROCESS | 12547 | _x_x_mozilla_cycle_collect,1011 15:38:45 INFO - PROCESS | 12547 | __end_cc_report 15:38:45 INFO - PROCESS | 12547 | __startTimestamp1452901125276__endTimestamp 15:38:45 INFO - PROCESS | 12547 | 15:38:45 INFO - PROCESS | 12547 | ------- Summary: start ------- 15:38:45 INFO - PROCESS | 12547 | Number of tests: 6 15:38:45 INFO - PROCESS | 12547 | 15:38:45 INFO - PROCESS | 12547 | [#0] dojo.html Cycles:165 Average:4376.66 Median:4493.55 stddev:435.02 (9.7%) stddev-sans-first:411.95 15:38:45 INFO - PROCESS | 12547 | Values: 2545.3 2580.0 2603.6 2617.5 2624.9 4320.5 4395.6 4418.3 4422.1 4471.1 4371.4 4432.8 4459.4 4471.8 4476.9 4101.0 4119.1 4119.4 4132.9 4156.7 3924.9 4180.2 4200.4 4220.5 4256.7 4019.8 4086.6 4089.5 4094.8 4161.1 4134.4 4146.4 4146.5 4153.0 4182.0 4108.1 4112.2 4124.7 4154.7 4163.4 4292.1 4353.7 4362.1 4371.8 4384.7 4697.9 4714.7 4719.0 4747.7 4751.4 4737.6 4741.2 4746.8 4782.8 4797.2 4297.7 4369.1 4372.7 4395.7 4408.7 4853.9 4865.9 4867.3 4873.6 4878.4 4666.3 4667.3 4667.4 4669.8 4695.4 4637.4 4695.0 4707.4 4712.1 4785.5 4693.6 4699.5 4715.9 4727.1 4752.3 4670.0 4673.5 4674.2 4677.0 4715.5 3884.2 3953.9 3955.4 3956.4 3972.9 3520.2 3523.0 3534.5 3537.0 3544.1 4089.4 4090.9 4096.5 4152.3 4157.1 4714.6 4717.4 4717.6 4725.6 4770.4 4070.3 4071.4 4071.7 4107.3 4112.4 4096.0 4169.2 4191.0 4201.0 4213.4 4491.4 4500.6 4507.3 4537.2 4541.1 4717.2 4726.3 4726.4 4738.0 4777.6 4405.4 4460.4 4483.8 4493.6 4498.3 4625.4 4639.7 4649.9 4657.7 4695.8 4749.5 4750.9 4751.4 4752.1 4795.4 4504.5 4570.9 4574.7 4628.0 4636.3 4434.5 4496.3 4591.7 4612.5 4629.1 4500.7 4516.3 4536.1 4539.4 4575.9 4471.5 4546.9 4553.9 4637.4 4649.4 4472.5 4495.3 4508.4 4536.3 4555.8 15:38:45 INFO - PROCESS | 12547 | 15:38:45 INFO - PROCESS | 12547 | [#1] ext.html Cycles:180 Average:38002.44 Median:32610.67 stddev:60987.20 (187.0%) stddev-sans-first:61093.24 15:38:45 INFO - PROCESS | 12547 | Values: 487.8 501.5 508.6 519.9 532.7 23854.3 24834.3 24847.1 24874.0 31972.7 34865.8 35429.8 35454.6 35458.8 35461.6 7560.6 7753.1 7759.7 7764.5 7765.8 7524.6 7687.6 7687.8 7688.5 7695.3 7602.9 7939.4 7941.9 7945.2 7952.2 7769.8 7892.8 7893.1 7899.2 7902.9 7557.1 7711.2 7713.7 7715.1 7722.1 35261.5 35779.0 35786.5 35800.8 35804.8 2877.5 3070.2 3119.3 3177.6 3346.2 26383.5 26776.0 26941.1 26951.0 27480.9 3186.5 3229.8 3234.7 3305.2 3348.8 196490.0 198400.0 199229.0 199327.0 200212.0 45793.5 47088.8 51895.7 52189.0 52194.5 43707.8 56821.4 57955.7 58034.4 58046.4 11465.7 11623.6 11626.4 11658.9 11687.3 7381.0 8716.7 8842.8 8843.5 8865.3 14933.3 18529.5 18628.7 18742.2 18792.0 7142.6 7382.0 7406.6 7435.4 7631.6 736.6 765.5 787.8 803.6 908.3 21705.3 22515.4 25165.2 26366.2 26401.2 885.1 930.2 941.3 993.2 993.6 11680.0 13419.3 13986.8 14023.7 14135.7 259333.0 260263.0 260855.0 261296.0 263523.0 36960.0 36996.8 37021.8 37110.0 37127.0 1171.6 1178.1 1189.8 1189.9 1190.4 23114.5 23389.8 23701.8 23769.0 23784.8 38703.6 38946.2 38961.8 38986.8 38992.4 235025.0 236169.0 238395.0 238972.0 239692.0 23387.6 23952.6 26627.3 27318.0 27351.9 31878.5 32088.4 32407.5 32472.5 32748.8 28170.7 29840.9 31005.4 34835.5 35170.6 28083.6 30199.7 30404.1 30654.5 31474.7 28368.1 28714.9 36247.5 36533.3 36745.6 30436.8 31367.7 31411.7 31759.7 31788.0 25234.0 25626.1 25887.6 25922.2 25938.2 15:38:45 INFO - PROCESS | 12547 | 15:38:45 INFO - PROCESS | 12547 | [#2] jquery.html Cycles:180 Average:21896.10 Median:5560.75 stddev:65332.87 (1174.9%) stddev-sans-first:65496.09 15:38:45 INFO - PROCESS | 12547 | Values: 340.1 340.6 342.4 343.2 345.3 11602.8 12154.5 13566.7 13869.8 15459.5 13872.9 14256.2 14365.1 14993.9 15009.8 4821.9 4872.4 5045.7 5047.7 5087.2 3652.0 3826.5 5511.4 5743.6 5751.4 5502.6 5658.0 5684.8 5709.1 5738.7 5610.1 5644.8 5648.0 5649.9 5656.6 4841.2 5030.2 5045.7 5050.5 5057.3 16840.8 17587.6 17751.8 17989.4 18056.1 1651.7 1828.2 1885.7 2131.3 2197.2 7993.4 8237.9 8309.8 8313.1 10365.4 1670.9 1747.7 1753.1 1761.1 1776.4 48399.8 48547.8 49007.3 49036.8 49195.8 9170.5 9185.9 9244.5 9319.4 9358.2 11708.5 11710.0 11711.2 11723.9 11769.1 6050.4 6200.4 6251.3 6342.2 6346.4 5848.3 5953.3 6021.3 6036.9 6048.4 3504.2 3696.0 3756.2 3892.4 4014.9 1581.3 1653.3 1669.9 1694.0 1706.9 780.1 839.4 855.1 864.2 884.4 13620.7 13752.7 13944.1 13950.7 14017.6 693.6 771.0 814.6 842.2 879.3 7364.3 7490.9 7710.8 7812.7 7942.4 391751.0 397019.0 398289.0 405359.0 406636.0 47184.0 58735.4 59013.0 59276.7 59588.4 956.5 972.7 981.1 983.8 987.2 12922.7 13004.0 13413.3 13430.1 13463.1 29383.4 29449.9 29588.0 29589.4 30187.5 37610.6 38630.0 39170.2 41345.0 43303.8 7541.3 7982.7 8158.3 8368.7 8579.2 9196.7 9304.7 9493.7 9515.2 9691.9 6193.6 6284.1 6323.8 6400.6 6453.0 5925.6 6338.7 6354.9 6424.0 6524.3 5961.9 6030.3 6346.3 6464.1 6505.7 8236.9 8312.3 8317.8 8385.1 8442.9 6955.6 8273.9 8295.2 8328.3 8376.7 15:38:45 INFO - PROCESS | 12547 | 15:38:45 INFO - PROCESS | 12547 | [#3] mootools.html Cycles:180 Average:4739.74 Median:5941.83 stddev:2469.58 (41.6%) stddev-sans-first:2461.81 15:38:45 INFO - PROCESS | 12547 | Values: 1155.4 1156.4 1188.8 1239.5 1565.6 6171.1 6498.4 6630.0 6647.9 6667.9 6806.0 6961.1 6963.0 6966.1 6970.9 1738.5 1792.6 2007.9 2047.5 2081.2 2074.4 2088.0 2088.8 2089.9 2091.6 1988.3 1989.5 2053.0 2053.4 2053.5 2004.8 2033.0 2035.5 2048.8 2050.3 2027.8 2045.4 2045.6 2046.3 2046.4 6629.4 6666.3 6669.7 6673.8 6675.2 3880.4 3985.9 3991.1 4008.1 4009.0 2545.4 2652.3 2658.8 2664.0 2677.3 781.4 802.5 818.5 850.2 864.9 9245.7 9265.4 9280.7 9292.3 9301.7 3629.3 3717.1 3719.5 3729.6 3772.8 7945.9 7946.0 7955.8 7960.8 7966.8 3922.9 3936.4 3948.7 3960.9 3972.6 3604.9 3605.1 3608.7 3608.9 3612.2 2928.1 2979.3 3193.2 3205.3 3273.3 1006.7 1008.8 1010.7 1031.7 1032.2 836.5 837.9 839.5 840.9 1028.6 6482.2 6496.3 6513.8 6542.1 6548.3 974.5 994.3 997.7 1003.8 1013.1 4764.8 4798.4 4875.4 4876.3 4877.0 8013.1 8221.3 8229.1 8251.8 8258.7 7993.3 8102.1 8155.7 8191.3 8207.2 6389.8 6434.3 6436.9 6454.4 6469.4 5972.7 5993.2 6028.2 6127.6 6155.5 7311.5 7419.3 7442.3 7466.7 7497.5 7366.6 7529.3 7531.8 7682.5 7707.5 5750.5 5803.8 5805.3 5806.0 5809.6 5713.3 5882.1 6029.8 6225.6 6242.4 6247.2 6313.8 6370.6 6384.4 6490.3 5846.5 5952.5 6006.1 6045.8 6055.4 6097.6 6110.5 6140.3 6247.7 6253.8 5737.3 5785.7 5787.1 5791.4 5797.0 5879.4 5881.2 5926.2 5929.6 5931.1 15:38:45 INFO - PROCESS | 12547 | 15:38:45 INFO - PROCESS | 12547 | [#4] prototype.html Cycles:180 Average:4566.36 Median:5298.26 stddev:1380.51 (26.1%) stddev-sans-first:1346.36 15:38:45 INFO - PROCESS | 12547 | Values: 279.0 284.9 285.6 291.4 293.1 4919.7 5084.4 5277.7 5290.9 5314.3 5141.5 5276.6 5305.6 5305.7 5313.2 4100.2 4101.1 4104.3 4114.1 4117.1 3847.1 3948.5 3959.2 4099.5 4119.3 3984.3 3991.2 3993.5 3994.7 4000.6 4001.2 4012.7 4019.4 4022.6 4025.9 3503.8 3506.5 3507.3 3508.0 3509.6 5083.4 5090.8 5097.6 5099.8 5104.1 4375.9 4542.1 4549.9 4550.8 4553.3 5461.5 5502.7 5503.6 5506.3 5514.8 3441.1 3534.7 3593.9 3708.0 3712.9 5723.6 5774.4 5791.5 5794.5 5825.7 3787.3 3789.9 3790.5 3798.2 3801.9 3854.8 3859.0 3859.0 3866.1 3866.8 4393.5 4479.0 4485.6 4491.3 4494.5 5514.7 5519.6 5521.8 5526.0 5531.2 1339.7 1351.8 1355.8 1355.9 1357.3 897.1 897.2 902.6 922.1 925.3 4877.1 4885.0 4887.8 4891.0 4892.8 5756.7 5758.9 5759.1 5762.0 5777.7 4892.9 4895.4 4899.8 4902.6 4903.4 3008.7 3063.5 3104.2 3106.7 3108.7 5398.4 5402.4 5403.0 5433.9 5449.2 5865.2 5908.8 5909.8 5912.1 5920.1 5434.6 5450.7 5452.5 5454.0 5456.1 5641.5 5760.0 5833.2 5838.0 5838.6 5374.9 5672.7 5673.3 5678.8 5681.8 5306.3 5338.0 5485.3 5501.5 5505.8 3812.0 3871.7 3875.7 3876.8 3878.3 5792.4 5793.7 5798.2 5805.4 5809.4 5376.8 5549.9 5582.3 5590.4 5597.2 5603.3 5604.7 5670.5 5674.7 5675.2 5477.3 5487.5 5488.1 5488.4 5488.8 5518.5 5626.4 5637.3 5637.9 5646.7 5443.9 5472.7 5480.9 5484.4 5485.2 15:38:45 INFO - PROCESS | 12547 | 15:38:45 INFO - PROCESS | 12547 | [#5] yui.html Cycles:180 Average:11401.12 Median:443.03 stddev:12562.03 (2835.5%) stddev-sans-first:12571.35 15:38:45 INFO - PROCESS | 12547 | Values: 654.3 667.7 672.3 704.8 709.4 10754.3 10864.4 10961.8 10966.0 10968.2 10919.3 11007.9 11017.6 12230.3 12476.3 598.1 758.8 769.2 770.0 770.9 588.4 588.6 590.2 605.3 662.6 792.2 799.4 799.7 799.8 800.7 623.8 630.7 778.5 792.8 792.9 586.9 587.2 588.1 588.1 588.8 11530.7 11550.6 11584.5 11589.9 11634.1 10718.4 10997.8 11178.0 11271.7 11550.8 8828.0 9113.2 9157.9 9201.3 9365.5 3131.2 3136.5 3190.4 3194.5 3223.7 39996.6 40080.0 40321.6 40326.8 40385.4 8615.2 8798.0 8857.5 9024.8 9027.7 15606.6 15611.1 15632.3 15655.0 15660.4 6238.2 6398.7 6427.0 6496.0 6662.4 3581.5 3595.9 3624.4 3651.8 3711.6 2487.3 2507.2 2507.4 2510.8 2513.9 442.5 443.5 443.7 444.2 471.7 381.2 395.1 406.2 421.4 512.5 7073.4 7082.9 7209.7 7378.0 8467.0 446.7 503.8 515.1 528.4 568.6 3196.3 3211.4 3231.7 3357.8 3361.9 42915.1 43153.4 43191.4 43282.8 43462.9 40996.6 41287.6 41311.2 41609.6 41800.6 34138.5 34715.7 36645.1 37433.0 37550.0 7519.8 7664.2 7876.2 8037.2 8180.0 28506.6 28511.3 28632.7 28839.9 28919.9 33894.0 34210.0 35794.8 35950.6 35969.6 9809.5 9828.8 9846.1 9869.4 9922.1 10187.3 10253.5 10370.2 10461.5 10549.9 9699.4 9739.1 9955.0 10025.1 10567.6 9500.4 9598.1 9642.8 9720.1 10080.6 9750.8 9966.2 10010.2 10141.9 10144.9 7964.5 8142.8 8206.0 8361.0 8482.0 8379.6 8908.5 8930.3 9012.5 9190.7 15:38:45 INFO - PROCESS | 12547 | -------- Summary: end -------- 15:38:45 INFO - PROCESS | 12547 | 15:38:46 INFO - TEST-INFO | 12547: exit 0 15:38:46 INFO - TEST-OK | dromaeo_css | took 1116968ms 15:38:46 INFO - TEST-START | kraken 15:38:46 INFO - operating with platform_type : linux_ 15:38:46 INFO - Initialising browser for kraken test... 15:38:46 INFO - TEST-INFO | started process 12745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp93gnpR/profile http://localhost:44715/getInfo.html) 15:38:50 INFO - PROCESS | 12745 | __metrics Screen width/height:1600/1200 15:38:50 INFO - PROCESS | 12745 | colorDepth:24 15:38:50 INFO - PROCESS | 12745 | Browser inner width/height: 1024/697 15:38:50 INFO - PROCESS | 12745 | __metrics 15:38:50 INFO - PROCESS | 12745 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:38:50 INFO - PROCESS | 12745 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:38:51 INFO - TEST-INFO | 12745: exit 0 15:38:51 INFO - Browser initialized. 15:38:51 INFO - Running cycle 1/1 for kraken test... 15:38:51 INFO - TEST-INFO | started process 12826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp93gnpR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:39:03 INFO - PROCESS | 12826 | RSS: Main: 149786624 15:39:03 INFO - PROCESS | 12826 | 15:39:06 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44715/tests/kraken/driver.html?testName=audio-beat-detection) 15:39:06 INFO - PROCESS | 12826 | RSS: Main: 186138624 15:39:06 INFO - PROCESS | 12826 | 15:39:09 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44715/tests/kraken/driver.html?testName=audio-dft) 15:39:10 INFO - PROCESS | 12826 | RSS: Main: 176959488 15:39:10 INFO - PROCESS | 12826 | 15:39:13 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44715/tests/kraken/driver.html?testName=audio-fft) 15:39:13 INFO - PROCESS | 12826 | RSS: Main: 163835904 15:39:13 INFO - PROCESS | 12826 | 15:39:15 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44715/tests/kraken/driver.html?testName=audio-oscillator) 15:39:16 INFO - PROCESS | 12826 | RSS: Main: 163356672 15:39:16 INFO - PROCESS | 12826 | 15:39:18 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44715/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:39:19 INFO - PROCESS | 12826 | RSS: Main: 164683776 15:39:19 INFO - PROCESS | 12826 | 15:39:22 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44715/tests/kraken/driver.html?testName=imaging-darkroom) 15:39:22 INFO - PROCESS | 12826 | RSS: Main: 166846464 15:39:22 INFO - PROCESS | 12826 | 15:39:26 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44715/tests/kraken/driver.html?testName=imaging-desaturate) 15:39:26 INFO - PROCESS | 12826 | RSS: Main: 166580224 15:39:26 INFO - PROCESS | 12826 | 15:39:29 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44715/tests/kraken/driver.html?testName=json-parse-financial) 15:39:30 INFO - PROCESS | 12826 | RSS: Main: 166297600 15:39:30 INFO - PROCESS | 12826 | 15:39:32 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44715/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:39:32 INFO - PROCESS | 12826 | RSS: Main: 175476736 15:39:32 INFO - PROCESS | 12826 | 15:39:34 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44715/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:39:35 INFO - PROCESS | 12826 | RSS: Main: 173715456 15:39:35 INFO - PROCESS | 12826 | 15:39:37 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44715/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:39:37 INFO - PROCESS | 12826 | RSS: Main: 185622528 15:39:37 INFO - PROCESS | 12826 | 15:39:40 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:39:40 INFO - PROCESS | 12826 | RSS: Main: 190701568 15:39:40 INFO - PROCESS | 12826 | 15:39:43 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:39:44 INFO - PROCESS | 12826 | RSS: Main: 186843136 15:39:44 INFO - PROCESS | 12826 | 15:39:45 INFO - PROCESS | 12826 | Cycle 1(1): loaded http://localhost:44715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44715/tests/kraken/driver.html?testName=ai-astar) 15:39:46 INFO - PROCESS | 12826 | RSS: Main: 244039680 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | __start_tp_report 15:39:46 INFO - PROCESS | 12826 | _x_x_mozilla_page_load 15:39:46 INFO - PROCESS | 12826 | _x_x_mozilla_page_load_details 15:39:46 INFO - PROCESS | 12826 | |i|pagename|runs| 15:39:46 INFO - PROCESS | 12826 | |0;ai-astar;112;114;109;115;113;113;102;112;112;113 15:39:46 INFO - PROCESS | 12826 | |1;audio-beat-detection;150;132;156;179;129;152;158;131;170;132 15:39:46 INFO - PROCESS | 12826 | |2;audio-dft;163;163;163;161;160;160;162;162;162;162 15:39:46 INFO - PROCESS | 12826 | |3;audio-fft;77;73;102;92;74;72;73;114;90;72 15:39:46 INFO - PROCESS | 12826 | |4;audio-oscillator;97;99;142;98;99;98;137;98;98;130 15:39:46 INFO - PROCESS | 12826 | |5;imaging-gaussian-blur;110;109;109;110;109;109;110;109;109;109 15:39:46 INFO - PROCESS | 12826 | |6;imaging-darkroom;147;147;146;146;148;147;147;146;147;147 15:39:46 INFO - PROCESS | 12826 | |7;imaging-desaturate;96;95;95;95;95;95;95;96;95;96 15:39:46 INFO - PROCESS | 12826 | |8;json-parse-financial;66;67;67;66;66;68;67;76;65;66 15:39:46 INFO - PROCESS | 12826 | |9;json-stringify-tinderbox;67;68;67;68;68;67;68;67;68;67 15:39:46 INFO - PROCESS | 12826 | |10;stanford-crypto-aes;83;85;84;84;85;83;85;85;89;84 15:39:46 INFO - PROCESS | 12826 | |11;stanford-crypto-ccm;121;123;121;127;131;123;121;119;119;122 15:39:46 INFO - PROCESS | 12826 | |12;stanford-crypto-pbkdf2;153;140;152;148;150;144;154;149;151;150 15:39:46 INFO - PROCESS | 12826 | |13;stanford-crypto-sha256-iterative;72;72;73;80;72;71;70;70;70;71 15:39:46 INFO - PROCESS | 12826 | __end_tp_report 15:39:46 INFO - PROCESS | 12826 | __start_cc_report 15:39:46 INFO - PROCESS | 12826 | _x_x_mozilla_cycle_collect,1006 15:39:46 INFO - PROCESS | 12826 | __end_cc_report 15:39:46 INFO - PROCESS | 12826 | __startTimestamp1452901186165__endTimestamp 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | ------- Summary: start ------- 15:39:46 INFO - PROCESS | 12826 | Number of tests: 14 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:3.69 (3.3%) stddev-sans-first:3.91 15:39:46 INFO - PROCESS | 12826 | Values: 112.0 114.0 109.0 115.0 113.0 113.0 102.0 112.0 112.0 113.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:154.00 stddev:17.58 (11.4%) stddev-sans-first:18.65 15:39:46 INFO - PROCESS | 12826 | Values: 150.0 132.0 156.0 179.0 129.0 152.0 158.0 131.0 170.0 132.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 15:39:46 INFO - PROCESS | 12826 | Values: 163.0 163.0 163.0 161.0 160.0 160.0 162.0 162.0 162.0 162.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#3] audio-fft Cycles:10 Average:83.90 Median:73.50 stddev:14.92 (20.3%) stddev-sans-first:15.61 15:39:46 INFO - PROCESS | 12826 | Values: 77.0 73.0 102.0 92.0 74.0 72.0 73.0 114.0 90.0 72.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:98.00 stddev:18.67 (19.1%) stddev-sans-first:19.24 15:39:46 INFO - PROCESS | 12826 | Values: 97.0 99.0 142.0 98.0 99.0 98.0 137.0 98.0 98.0 130.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 15:39:46 INFO - PROCESS | 12826 | Values: 110.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 15:39:46 INFO - PROCESS | 12826 | Values: 147.0 147.0 146.0 146.0 148.0 147.0 147.0 146.0 147.0 147.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 15:39:46 INFO - PROCESS | 12826 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:67.00 stddev:3.13 (4.7%) stddev-sans-first:3.28 15:39:46 INFO - PROCESS | 12826 | Values: 66.0 67.0 67.0 66.0 66.0 68.0 67.0 76.0 65.0 66.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 15:39:46 INFO - PROCESS | 12826 | Values: 67.0 68.0 67.0 68.0 68.0 67.0 68.0 67.0 68.0 67.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:1.70 (2.0%) stddev-sans-first:1.69 15:39:46 INFO - PROCESS | 12826 | Values: 83.0 85.0 84.0 84.0 85.0 83.0 85.0 85.0 89.0 84.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:122.50 stddev:3.71 (3.0%) stddev-sans-first:3.89 15:39:46 INFO - PROCESS | 12826 | Values: 121.0 123.0 121.0 127.0 131.0 123.0 121.0 119.0 119.0 122.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:150.50 stddev:4.25 (2.8%) stddev-sans-first:4.27 15:39:46 INFO - PROCESS | 12826 | Values: 153.0 140.0 152.0 148.0 150.0 144.0 154.0 149.0 151.0 150.0 15:39:46 INFO - PROCESS | 12826 | 15:39:46 INFO - PROCESS | 12826 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:2.96 (4.1%) stddev-sans-first:3.14 15:39:46 INFO - PROCESS | 12826 | Values: 72.0 72.0 73.0 80.0 72.0 71.0 70.0 70.0 70.0 71.0 15:39:46 INFO - PROCESS | 12826 | -------- Summary: end -------- 15:39:46 INFO - PROCESS | 12826 | 15:39:47 INFO - TEST-INFO | 12826: exit 0 15:39:47 INFO - TEST-OK | kraken | took 61106ms 15:39:47 INFO - TEST-START | v8_7 15:39:47 INFO - operating with platform_type : linux_ 15:39:47 INFO - Initialising browser for v8_7 test... 15:39:47 INFO - TEST-INFO | started process 13073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp60KwrU/profile http://localhost:44715/getInfo.html) 15:39:51 INFO - PROCESS | 13073 | __metrics Screen width/height:1600/1200 15:39:51 INFO - PROCESS | 13073 | colorDepth:24 15:39:51 INFO - PROCESS | 13073 | Browser inner width/height: 1024/697 15:39:51 INFO - PROCESS | 13073 | __metrics 15:39:51 INFO - PROCESS | 13073 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:39:51 INFO - PROCESS | 13073 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:39:53 INFO - TEST-INFO | 13073: exit 0 15:39:53 INFO - Browser initialized. 15:39:53 INFO - Running cycle 1/1 for v8_7 test... 15:39:53 INFO - TEST-INFO | started process 13154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp60KwrU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:04 INFO - PROCESS | 13154 | RSS: Main: 150216704 15:40:04 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:44715/tests/v8_7/run.html (next: http://localhost:44715/tests/v8_7/run.html) 15:40:27 INFO - PROCESS | 13154 | RSS: Main: 447578112 15:40:27 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | __start_tp_report 15:40:27 INFO - PROCESS | 13154 | _x_x_mozilla_page_load 15:40:27 INFO - PROCESS | 13154 | _x_x_mozilla_page_load_details 15:40:27 INFO - PROCESS | 13154 | |i|pagename|runs| 15:40:27 INFO - PROCESS | 13154 | |0;Richards;168.52039096730704 15:40:27 INFO - PROCESS | 13154 | |1;DeltaBlue;187.79342723004694 15:40:27 INFO - PROCESS | 13154 | |2;Encrypt;278.31895352073474 15:40:27 INFO - PROCESS | 13154 | |3;Decrypt;5256.544502617801 15:40:27 INFO - PROCESS | 13154 | |4;RayTrace;2072.463768115942 15:40:27 INFO - PROCESS | 13154 | |5;Earley;805.1529790660226 15:40:27 INFO - PROCESS | 13154 | |6;Boyer;12358.024691358025 15:40:27 INFO - PROCESS | 13154 | |7;RegExp;43826.086956521736 15:40:27 INFO - PROCESS | 13154 | |8;Splay;595.1393005334915 15:40:27 INFO - PROCESS | 13154 | |9;NavierStokes;4830.917874396136 15:40:27 INFO - PROCESS | 13154 | __end_tp_report 15:40:27 INFO - PROCESS | 13154 | __startTimestamp1452901227755__endTimestamp 15:40:27 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | ------- Summary: start ------- 15:40:27 INFO - PROCESS | 13154 | Number of tests: 10 15:40:27 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | [#0] Richards Cycles:1 Average:168.52 Median:168.52 stddev:0.00 (0.0%) 15:40:27 INFO - PROCESS | 13154 | Values: 168.5 15:40:27 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | [#1] DeltaBlue Cycles:1 Average:187.79 Median:187.79 stddev:0.00 (0.0%) 15:40:27 INFO - PROCESS | 13154 | Values: 187.8 15:40:27 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 15:40:27 INFO - PROCESS | 13154 | Values: 278.3 15:40:27 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 15:40:27 INFO - PROCESS | 13154 | Values: 5256.5 15:40:27 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | [#4] RayTrace Cycles:1 Average:2072.46 Median:2072.46 stddev:0.00 (0.0%) 15:40:27 INFO - PROCESS | 13154 | Values: 2072.5 15:40:27 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | [#5] Earley Cycles:1 Average:805.15 Median:805.15 stddev:0.00 (0.0%) 15:40:27 INFO - PROCESS | 13154 | Values: 805.2 15:40:27 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 15:40:27 INFO - PROCESS | 13154 | Values: 12358.0 15:40:27 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | [#7] RegExp Cycles:1 Average:43826.09 Median:43826.09 stddev:0.00 (0.0%) 15:40:27 INFO - PROCESS | 13154 | Values: 43826.1 15:40:27 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | [#8] Splay Cycles:1 Average:595.14 Median:595.14 stddev:0.00 (0.0%) 15:40:27 INFO - PROCESS | 13154 | Values: 595.1 15:40:27 INFO - PROCESS | 13154 | 15:40:27 INFO - PROCESS | 13154 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 15:40:27 INFO - PROCESS | 13154 | Values: 4830.9 15:40:27 INFO - PROCESS | 13154 | -------- Summary: end -------- 15:40:27 INFO - PROCESS | 13154 | 15:40:28 INFO - TEST-INFO | 13154: exit 0 15:40:28 INFO - TEST-OK | v8_7 | took 41526ms 15:40:28 INFO - SUITE-END | took 1219s 15:40:28 INFO - Completed test suite (00:20:19) 15:40:28 INFO - Working with test: dromaeo_css 15:40:28 INFO - Generating results file: dromaeo_css 15:40:28 INFO - Working with test: kraken 15:40:28 INFO - Generating results file: kraken 15:40:28 INFO - javascript benchmark 15:40:28 INFO - Working with test: v8_7 15:40:28 INFO - Generating results file: v8_7 15:40:28 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:40:28 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 15:40:28 INFO - process_Request line: dromaeo_css 5885.11 graph.html#tests=[[72,94,35]] 15:40:28 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:40:28 INFO - process_Request line: kraken 1530.60 graph.html#tests=[[232,94,35]] 15:40:28 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:40:29 INFO - process_Request line: v8_7 18710.38 graph.html#tests=[[230,94,35]] 15:40:29 INFO - RETURN: dromaeo_css: 5885.11 15:40:29 INFO - RETURN: kraken: 1530.60 15:40:29 INFO - RETURN: v8_7: 18710.38 15:40:29 INFO - javascript benchmark 15:40:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2545.274596739929, 2580.045383208213, 2603.6485074514935, 2617.489589530041, 2624.855632940188, 4320.546342634026, 4395.560443955603, 4418.337249412586, 4422.071365013347, 4471.083427897282, 4371.388005679208, 4432.822687092521, 4459.397981272527, 4471.754053527055, 4476.910461790762, 4100.979495102535, 4119.0937993641355, 4119.361498967664, 4132.855350062733, 4156.729812562189, 3924.9018774530578, 4180.24755544002, 4200.390943313218, 4220.451341325639, 4256.659467242614, 4019.778912159845, 4086.5504794472586, 4089.488813898263, 4094.7747873866924, 4161.0845613964875, 4134.400511925784, 4146.4402305688645, 4146.502419709624, 4153.0447996960565, 4181.979090104561, 4108.116754897682, 4112.218678451115, 4124.731892426983, 4154.729942553724, 4163.437935878678, 4292.098659281554, 4353.673474489426, 4362.127574485084, 4371.803268852909, 4384.671149663756, 4697.906041879143, 4714.693544919569, 4719.032598317337, 4747.6914000590195, 4751.40607424072, 4737.644676649265, 4741.170295198326, 4746.786394612251, 4782.760861956888, 4797.232442809169, 4297.720648157829, 4369.06065195978, 4372.693911426233, 4395.714278571946, 4408.669349798778, 4853.854384368475, 4865.854024379274, 4867.342908707279, 4873.634477414137, 4878.390201224847, 4666.323383109498, 4667.276572131325, 4667.439907211156, 4669.813207471731, 4695.366125573072, 4637.373954516164, 4695.0, 4707.435107787019, 4712.057588482317, 4785.545373189541, 4693.601043911306, 4699.465016259326, 4715.905681886343, 4727.078219747116, 4752.334673145762, 4669.95330046702, 4673.509281525459, 4674.158651442773, 4676.976615116971, 4715.4577223619035, 3884.1843212925037, 3953.881383558498, 3955.3869150281753, 3956.40653901917, 3972.920541589152, 3520.1727594015388, 3523.0, 3534.4698295255916, 3536.964630353715, 3544.0608238816217, 4089.427480152781, 4090.877273681794, 4096.508418989681, 4152.294110001307, 4157.127003329274, 4714.57568818808, 4717.386739723814, 4717.575418212377, 4725.5510726480925, 4770.403699537558, 4070.287699652549, 4071.4096456013713, 4071.714979951375, 4107.322291821875, 4112.424260603518, 4095.97952010244, 4169.1661667666585, 4190.958090419118, 4200.978995105066, 4213.367994800743, 4491.416115904912, 4500.617447516932, 4507.323901414748, 4537.1833070047705, 4541.137183935041, 4717.245240761462, 4726.291056341576, 4726.432828060655, 4737.952620473889, 4777.641676874317, 4405.449318835145, 4460.397846290709, 4483.7533935633855, 4493.550644935611, 4498.347739577808, 4625.444946606429, 4639.652026098123, 4649.907001860011, 4657.69724967876, 4695.835645752382, 4749.525047495223, 4750.928736068892, 4751.358566593465, 4752.097101550833, 4795.352627395257, 4504.504504504567, 4570.88572785683, 4574.679772415899, 4627.9768601156775, 4636.258198688193, 4434.467863856358, 4496.348029535634, 4591.724496530219, 4612.4926258112255, 4629.097326021393, 4500.662450316305, 4516.345129956072, 4536.070105628272, 4539.432570928634, 4575.862724118282, 4471.463424389094, 4546.909061818811, 4553.9316910247035, 4637.3739545162325, 4649.372334734768, 4472.530384309731, 4495.25828238337, 4508.413906192174, 4536.274196128604, 4555.817767289272], "unit": "score", "name": "dojo.html", "value": 4350.862599309024}, {"lowerIsBetter": false, "replicates": [487.81706859927505, 501.4734528744817, 508.56517677385835, 519.9055987147054, 532.7096732280907, 23854.28437146886, 24834.254972350835, 24847.13035043774, 24874.0, 31972.68027319726, 34865.82567087167, 35429.82285088571, 35454.645453545454, 35458.822705886436, 35461.64538354616, 7560.584167870778, 7753.069631644211, 7759.680854254762, 7764.534127952341, 7765.844683106335, 7524.586147761871, 7687.615619219045, 7687.846243075135, 7688.461807673465, 7695.268949449794, 7602.885956710654, 7939.36485081195, 7941.880871786928, 7945.245201705829, 7952.165022672622, 7769.844603107935, 7892.763217103496, 7893.052833659997, 7899.249571290776, 7902.920970790334, 7557.093148822121, 7711.151773304932, 7713.730019449348, 7715.112762032326, 7722.11195712489, 35261.47107793385, 35779.0, 35786.46320305197, 35800.82099589486, 35804.82097589495, 2877.510823160047, 3070.186400603842, 3119.298157914474, 3177.5998092247823, 3346.2470944037395, 26383.47233055347, 26776.0, 26941.057063002896, 26951.0, 27480.862595686893, 3186.5379519969474, 3229.790063645879, 3234.7250483708913, 3305.206750379916, 3348.815815130167, 196490.0, 198400.0, 199228.99999999854, 199327.0, 200212.0, 45793.481358524936, 47088.76455617769, 51895.74052129791, 52189.0, 52194.47805521972, 43707.78146109249, 56821.43178568244, 57955.710221449466, 58034.419655803744, 58046.41953580495, 11465.713357166138, 11623.59317423886, 11626.418679066013, 11658.883411165949, 11687.298762074302, 7380.96309518449, 8716.738497845075, 8842.778930526789, 8843.513606751561, 8865.290776737975, 14933.25333733309, 18529.53676158107, 18628.72056919147, 18742.1566029529, 18792.0, 7142.642867856586, 7382.0, 7406.592637404994, 7435.40516758658, 7631.618419079024, 736.6390468670313, 765.5215490318551, 787.8266781308103, 803.5580430763057, 908.3414524469706, 21705.34883953484, 22515.437114071952, 25165.24504264875, 26366.209013729618, 26401.207963761117, 885.0927799005941, 930.1582068228264, 941.3457646935451, 993.2252842782497, 993.5876611206413, 11680.0, 13419.261940593362, 13986.790198147037, 14023.719525609635, 14135.71728565423, 259333.0, 260263.0, 260855.0, 261296.0, 263523.0, 36960.0, 36996.815015924745, 37021.81489092537, 37110.0, 37127.0, 1171.6133675886938, 1178.0987544528443, 1189.8036823924128, 1189.9464524096436, 1190.4047976012166, 23114.53770924606, 23389.76610233876, 23701.762982370645, 23769.0, 23784.762152378255, 38703.61296387, 38946.2210755789, 38961.805190973864, 38986.80506597449, 38992.415113772746, 235025.0, 236169.0, 238395.0, 238972.0, 239692.0, 23387.649185262577, 23952.64071038901, 26627.33431664224, 27318.0, 27351.86324068367, 31878.52182217315, 32088.35823283568, 32407.51388729218, 32472.512912306807, 32748.83625581857, 28170.718292816808, 29840.850795745882, 31005.379892401575, 34835.47746783851, 35170.64829351776, 28083.578746319232, 30199.69800301969, 30404.087877363716, 30654.540181897737, 31474.685253147174, 28368.148955531367, 28714.85642571774, 36247.45628815622, 36533.269334612625, 36745.63254367422, 30436.847815761666, 31367.686323136477, 31411.685883140875, 31759.682403175673, 31788.0, 25234.0, 25626.103086391886, 25887.611685825104, 25922.22233333003, 25938.22185334443], "unit": "score", "name": "ext.html", "value": 15740.491024897037}, {"lowerIsBetter": false, "replicates": [340.0648217402144, 340.62190968025504, 342.40592571887777, 343.23116219667946, 345.3266131044464, 11602.767944641102, 12154.513819447233, 13566.660833479156, 13869.791953120699, 15459.536213913601, 13872.861271387283, 14256.215908125048, 14365.066270692398, 14993.85006149938, 15009.849901500982, 4821.90356192876, 4872.440818937941, 5045.697258164503, 5047.67190132642, 5087.160618497944, 3652.0322114639644, 3826.5408151021916, 5511.421300763423, 5743.597948143632, 5751.4248575142365, 5502.5597952163935, 5658.0381335172915, 5684.8294551163535, 5709.0580054290995, 5738.6556806591525, 5610.07433773429, 5644.8306550803545, 5648.039833228361, 5649.943500564983, 5656.632318899258, 4841.2496063110275, 5030.245463180516, 5045.672031317952, 5050.545450909436, 5057.342545469065, 16840.831591684047, 17587.648247034987, 17751.822481775147, 17989.370372036916, 18056.097195140323, 1651.7357222844407, 1828.1590468384427, 1885.7359969604267, 2131.2860191835753, 2197.1760589778833, 7993.360531157494, 8237.876431853527, 8309.8338033239, 8313.08556058833, 10365.429901355423, 1670.9081000544966, 1747.6766798142385, 1753.0883940351073, 1761.0842361971702, 1776.351631654437, 48399.75800120977, 48547.757261213825, 49007.264891026665, 49036.75481622605, 49195.75402123002, 9170.541472926327, 9185.862212066824, 9244.491552964517, 9319.394239374418, 9358.204552613104, 11708.473118709679, 11710.0, 11711.1802173847, 11723.941380293043, 11769.058475321954, 6050.394960503914, 6200.3799620038535, 6251.281102673251, 6342.175517182829, 6346.397092276226, 5848.298204215522, 5953.315368732565, 6021.277446706424, 6036.939630603725, 6048.425399587032, 3504.2465869838106, 3695.9630403696156, 3756.154865155318, 3892.4355968384425, 4014.9197016059516, 1581.3437423469131, 1653.2725600735637, 1669.8998060116432, 1693.9576510587333, 1706.8634509239232, 780.1223623423648, 839.4375768235298, 855.1405837133641, 864.1833467373272, 884.4428010353436, 13620.727585448236, 13752.65618359529, 13944.093633913762, 13950.720985580232, 14017.649558761113, 693.5665209244222, 770.9807254818675, 814.5764202614607, 842.1872892658614, 879.3053487744738, 7364.3003914628025, 7490.887636685454, 7710.845783084307, 7812.726554570563, 7942.3646108311195, 391751.0, 397019.0, 398289.0, 405359.0, 406636.0, 47184.0, 58735.41264587385, 59013.0, 59276.703616482504, 59588.40411595915, 956.5217391304348, 972.7130496503548, 981.087588542648, 983.7589790501373, 987.2003677021636, 12922.676933076747, 13004.024698147867, 13413.32933353348, 13430.0598958072, 13463.05758596928, 29383.412331753672, 29449.852750736965, 29588.0, 29589.408211836075, 30187.547186792654, 37610.62389376071, 38630.0, 39170.2165956685, 41345.0, 43303.78348108239, 7541.283578060075, 7982.680692772224, 8158.265756081981, 8368.748937531884, 8579.184977427134, 9196.678116265899, 9304.674336398193, 9493.66772162971, 9515.191208747334, 9691.854622180814, 6193.628382297076, 6284.08880712285, 6323.841903952254, 6400.647964362005, 6453.0, 5925.555583331181, 6338.651374174465, 6354.872902541831, 6424.036394540856, 6524.347565243438, 5961.850953726192, 6030.276366836008, 6346.333634968447, 6464.127342808849, 6505.7072431741635, 8236.876446853423, 8312.293455056146, 8317.792055198668, 8385.077641459313, 8442.873356899529, 6955.582665040114, 8273.917260827315, 8295.170482951899, 8328.250457458858, 8376.664933402595], "unit": "score", "name": "jquery.html", "value": 7136.9036102311975}, {"lowerIsBetter": false, "replicates": [1155.4396117882825, 1156.4449064449063, 1188.8097904335305, 1239.5289789879844, 1565.6242501799563, 6171.074338849169, 6498.447631951284, 6630.03864439656, 6647.867042659156, 6667.899981500282, 6806.0, 6961.060256865334, 6963.0251764752975, 6966.094407727001, 6970.895436568456, 1738.521906475723, 1792.5877048278903, 2007.9397618071482, 2047.4778931372516, 2081.1779347157863, 2074.3569493457076, 2088.049937278535, 2088.822450091744, 2089.853710240284, 2091.6130515854616, 1988.2742798878378, 1989.512569420494, 2052.9794702052936, 2053.37372101509, 2053.537953960362, 2004.7894971028124, 2032.9695054574192, 2035.5114772454651, 2048.8053634904736, 2050.282401159582, 2027.8377729781582, 2045.4068320187127, 2045.6420126477806, 2046.3451695457459, 2046.4270004398793, 6629.403353698142, 6666.333366663343, 6669.733210671568, 6673.766418175341, 6675.165604299463, 3880.3597406427907, 3985.920281594381, 3991.1219531702977, 4008.0581063450068, 4009.0, 2545.350935511451, 2652.2971412575685, 2658.827176233558, 2663.9600405993924, 2677.3306673331667, 781.4217479065508, 802.4904185841974, 818.4925346285341, 850.1668365002332, 864.9091845356273, 9245.72262832116, 9265.397749146352, 9280.675176368863, 9292.256619470427, 9301.674441394518, 3629.256002519477, 3717.0893131183034, 3719.479272901796, 3729.6083911189476, 3772.773633581994, 7945.880811787828, 7946.0, 7955.8408831823035, 7960.761177164694, 7966.7609971699785, 3922.941155882664, 3936.389859571771, 3948.664363529132, 3960.881173564798, 3972.64246217836, 3604.873829415958, 3605.0626837022564, 3608.657177568127, 3608.891733248007, 3612.1872578670113, 2928.1361998210577, 2979.3445442002726, 3193.1697758582472, 3205.3108581655056, 3273.263515708994, 1006.7030226083323, 1008.8436292374547, 1010.7018429563296, 1031.7111208861531, 1032.210359075308, 836.5440834745078, 837.9287760540423, 839.5298632765671, 840.8570543007703, 1028.6348346336943, 6482.157319548429, 6496.285408605049, 6513.804585862432, 6542.084108224853, 6548.345165483509, 974.4883935933692, 994.2841154368988, 997.7006897930737, 1003.7841863999275, 1013.0932815130565, 4764.785584648699, 4798.4001999750035, 4875.414950205927, 4876.341693871353, 4877.048975449753, 8013.078495973038, 8221.260086592116, 8229.094799572042, 8251.752447426587, 8258.710945116893, 7993.280604745601, 8102.108768035511, 8155.673773049011, 8191.344692424592, 8207.220314070153, 6389.808305750835, 6434.292227854932, 6436.871262574722, 6454.419102280817, 6469.385408386196, 5972.701364931823, 5993.190919225849, 6028.216331876828, 6127.632342059491, 6155.4767844731905, 7311.488195826454, 7419.258074192538, 7442.255774422514, 7466.664000120117, 7497.512661676974, 7366.594837284001, 7529.284717951786, 7531.811704707207, 7682.539047657158, 7707.499012564165, 5750.482456578928, 5803.82588522345, 5805.303363596396, 5806.0, 5809.564282678901, 5713.285839270091, 5882.058870580687, 6029.8191054268445, 6225.595336303126, 6242.406971337716, 6247.219097612799, 6313.810585682437, 6370.649614271074, 6384.3934826191435, 6490.318516555693, 5846.532277417881, 5952.5237980960555, 6006.099085137264, 6045.818625441244, 6055.364186760326, 6097.634141951497, 6110.450059494667, 6140.263168419819, 6247.718852651551, 6253.812385628438, 5737.282839645044, 5785.652860828363, 5787.074068149076, 5791.449812267828, 5796.971015144897, 5879.412058794086, 5881.176635271151, 5926.170336153028, 5929.555283353852, 5931.13998470228], "unit": "score", "name": "mootools.html", "value": 3878.6890172404965}, {"lowerIsBetter": false, "replicates": [279.03315013478294, 284.9031329348021, 285.5702168236803, 291.42879955287634, 293.09579945866994, 4919.680220785646, 5084.38987321521, 5277.70972596507, 5290.947090529094, 5314.256004159416, 5141.511556402145, 5276.604254680895, 5305.575553955684, 5305.734713264341, 5313.1764576490705, 4100.200460910124, 4101.056756945904, 4104.302268614335, 4114.136031433388, 4117.114820313632, 3847.0574709196285, 3948.5261768587666, 3959.227950549644, 4099.487564054493, 4119.258533463975, 3984.3425834737377, 3991.161856010227, 3993.480847489837, 3994.720369574131, 4000.6199411055904, 4001.1997600479876, 4012.7391719538136, 4019.356902895537, 4022.557518672973, 4025.879223623296, 3503.7722548034553, 3506.526618906466, 3507.3160733656946, 3507.9824600877087, 3509.5613048368955, 5083.415407228142, 5090.77091530882, 5097.617678674077, 5099.796008159669, 5104.132297509395, 4375.868723938287, 4542.136993971135, 4549.909001819979, 4550.795214215368, 4553.271476563734, 5461.5357694596005, 5502.697351645658, 5503.587230957694, 5506.311711036121, 5514.80698175562, 3441.105312618712, 3534.717222622184, 3593.94609080864, 3708.0173753955223, 3712.9071773205887, 5723.599348045638, 5774.422557744234, 5791.536677065825, 5794.536437085023, 5825.737841797087, 3787.3182827091387, 3789.9431508527396, 3790.5451345838123, 3798.2023775007005, 3801.8669346573292, 3854.845806167722, 3858.961410385916, 3859.0159509324944, 3866.0914685048992, 3866.845326186977, 4393.450818647669, 4479.037007043501, 4485.641148708096, 4491.326301054803, 4494.52807455219, 5514.724263786875, 5519.586031047687, 5521.751521181556, 5526.0, 5531.170324451365, 1339.7186590815843, 1351.7837146056584, 1355.830521184852, 1355.8915286777035, 1357.321339330335, 897.1432282170512, 897.2014906733012, 902.6208992223281, 922.0917396364575, 925.2782829393084, 4877.097736918681, 4885.047415753894, 4887.755612219375, 4891.0, 4892.804287828447, 5756.683382414008, 5758.942410575924, 5759.107338362561, 5761.971190144106, 5777.653340799566, 4892.877678058077, 4895.363602731693, 4899.804007839646, 4902.583280421204, 4903.436104847917, 3008.7292143707173, 3063.4945234036136, 3104.161876293388, 3106.6582675905634, 3108.735757460596, 5398.352197736297, 5402.432744561843, 5403.0, 5433.891322173614, 5449.237106805051, 5865.178874957509, 5908.793192238337, 5909.793157239562, 5912.142739302777, 5920.141579470953, 5434.592405569598, 5450.727463626803, 5452.5365343946205, 5454.0, 5456.127019676833, 5641.5204707600315, 5760.0, 5833.212516310244, 5837.970810145922, 5838.649681019152, 5374.892502150014, 5672.744726487401, 5673.347565030074, 5678.801241956512, 5681.801136960186, 5306.257124002565, 5338.012467693489, 5485.286912701324, 5501.504864562208, 5505.752241149238, 3812.0, 3871.670907972854, 3875.6705680016385, 3876.806159691948, 3878.26313000529, 5792.362840087671, 5793.681347525927, 5798.159266906359, 5805.448482394166, 5809.419058094157, 5376.838694839004, 5549.916751248816, 5582.302212223472, 5590.413006634245, 5597.188407680945, 5603.32760068778, 5604.747786349542, 5670.5180059695385, 5674.659520428788, 5675.177099320493, 5477.315335583052, 5487.506124448819, 5488.121900495901, 5488.396276409512, 5488.835334939959, 5518.475744804237, 5626.38109807929, 5637.267155269788, 5637.943620563742, 5646.71766411686, 5443.918341224964, 5472.671639701472, 5480.890382192254, 5484.396716361117, 5485.177223416519], "unit": "score", "name": "prototype.html", "value": 4114.502336988416}, {"lowerIsBetter": false, "replicates": [654.283559502345, 667.6928612838095, 672.2605134352211, 704.8061783009668, 709.3934685843607, 10754.300970436925, 10864.402457864815, 10961.780764384708, 10966.0, 10968.17738669599, 10919.344839309648, 11007.889921100787, 11017.614383496579, 12230.266184028964, 12476.251424914512, 598.1207624791549, 758.7761610324967, 769.1731388757081, 769.9576523291216, 770.9421793365492, 588.355750453253, 588.5556404914283, 590.2444870565662, 605.2646035067393, 662.6256165266633, 792.188007292524, 799.400449662753, 799.7041094794934, 799.7520768561735, 800.6677228949978, 623.7785586116931, 630.7098734582098, 778.5017588743209, 792.7780221537979, 792.8572856885759, 586.8972929737322, 587.2014060877203, 588.0796553393925, 588.1266319515516, 588.814523425124, 11530.654080377602, 11550.59572914944, 11584.536618535249, 11589.94205028978, 11634.069274458108, 10718.356898586031, 10997.780044399147, 11178.04986576142, 11271.661850144508, 11550.768984620261, 8827.99850541786, 9113.179813816789, 9157.908420915772, 9201.309901757395, 9365.531723413802, 3131.170239886432, 3136.4511210538294, 3190.361927614463, 3194.472911969522, 3223.725983291423, 39996.60003399958, 40080.0, 40321.59678403208, 40326.798366008275, 40385.39421908644, 8615.181557752003, 8797.956010220036, 8857.512836794038, 9024.819503610022, 9027.729168124966, 15606.609834753996, 15611.141387223812, 15632.296546655427, 15655.0, 15660.373585056697, 6238.157848690459, 6398.744050238031, 6426.967865160737, 6496.025596160519, 6662.400383965466, 3581.5164952731047, 3595.9280814383565, 3624.4200927851416, 3651.8174091295327, 3711.55461344635, 2487.3035550046015, 2507.210228777929, 2507.4107584717576, 2510.8367956082798, 2513.924582262535, 442.5264966485829, 443.54093513214315, 443.6716829546177, 444.23147954039695, 471.7429001194357, 381.16144482139407, 395.09326096607776, 406.23019378277996, 421.3700517725958, 512.477273181353, 7073.434125269966, 7082.893756593655, 7209.747658831916, 7377.963110184414, 8467.0, 446.6583063956076, 503.7733020140951, 515.1448595331732, 528.4372143666982, 568.590614757374, 3196.264859082424, 3211.3577284542716, 3231.6768323167494, 3357.78174418662, 3361.9495707564406, 42915.141697165884, 43153.35269970953, 43191.35212971808, 43282.78358608187, 43462.91342716394, 40996.59003409987, 41287.58712412897, 41311.1737765243, 41609.58390416057, 41800.581994179665, 34138.48792268118, 34715.65284347175, 36645.083872902855, 37433.0, 37550.0, 7519.849603008019, 7664.233576642291, 7876.173001834954, 8037.156098609562, 8180.0, 28506.57240141441, 28511.28721781889, 28632.713672863003, 28839.855800720863, 28919.855400723703, 33894.0, 34210.0, 35794.82102589471, 35950.640493595776, 35969.64030359768, 9809.460479673686, 9828.803423931624, 9846.064623860722, 9869.358491698016, 9922.115973948883, 10187.337823041478, 10253.48732563354, 10370.170386369224, 10461.47692615351, 10549.9472502637, 9699.418034917646, 9739.123478886933, 9955.0, 10025.147862431484, 10567.577296908037, 9500.382475139093, 9598.088181622734, 9642.758931026781, 9720.07659272368, 10080.647177348757, 9750.804983900423, 9966.152877005536, 10010.199184065112, 10141.898581014391, 10144.949275253577, 7964.482308649919, 8142.7557173284895, 8206.0, 8360.958195208985, 8482.024567174607, 8379.622916968628, 8908.465492070496, 8930.285577153942, 9012.504312262889, 9190.678326258549], "unit": "score", "name": "yui.html", "value": 5325.743220649693}], "name": "dromaeo_css", "value": 5885.116790553496}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 109.0, 115.0, 113.0, 113.0, 102.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [150.0, 132.0, 156.0, 179.0, 129.0, 152.0, 158.0, 131.0, 170.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 161.0, 160.0, 160.0, 162.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 102.0, 92.0, 74.0, 72.0, 73.0, 114.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.9}, {"lowerIsBetter": true, "replicates": [97.0, 99.0, 142.0, 98.0, 99.0, 98.0, 137.0, 98.0, 98.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 68.0, 67.0, 76.0, 65.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 67.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 84.0, 85.0, 83.0, 85.0, 85.0, 89.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [121.0, 123.0, 121.0, 127.0, 131.0, 123.0, 121.0, 119.0, 119.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [153.0, 140.0, 152.0, 148.0, 150.0, 144.0, 154.0, 149.0, 151.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 80.0, 72.0, 71.0, 70.0, 70.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.1}], "name": "kraken", "value": 1530.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.52039096730704], "unit": "score", "name": "Richards", "value": 209.48206800000006}, {"lowerIsBetter": false, "replicates": [187.79342723004694], "unit": "score", "name": "DeltaBlue", "value": 352.0783499999999}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [2072.463768115942], "unit": "score", "name": "RayTrace", "value": 357.0576293706293}, {"lowerIsBetter": false, "replicates": [805.1529790660226], "unit": "score", "name": "Earley", "value": 827.747046}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [43826.086956521736], "unit": "score", "name": "RegExp", "value": 20.786364087301607}, {"lowerIsBetter": false, "replicates": [595.1393005334915], "unit": "score", "name": "Splay", "value": 136.9276065737051}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18710.384487638417}]} 15:40:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "18710.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1530.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5885.11"}}} 15:40:29 INFO - Return code: 0 15:40:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:40:29 INFO - # TBPL SUCCESS # 15:40:29 INFO - Running post-action listener: _resource_record_post_action 15:40:29 INFO - Running post-run listener: _resource_record_post_run 15:40:30 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 0; Write bytes: 549482496; Read time: 0; Write time: 539904 15:40:30 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232103936; Read time: 0; Write time: 238244 15:40:30 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 308989952; Read time: 0; Write time: 301248 15:40:30 INFO - Running post-run listener: _upload_blobber_files 15:40:30 INFO - Blob upload gear active. 15:40:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:40:30 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 15:40:30 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'] 15:40:30 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 15:40:30 INFO - (blobuploader) - INFO - Open directory for files ... 15:40:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:40:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:40:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:31 INFO - (blobuploader) - INFO - Done attempting. 15:40:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:40:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:40:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:32 INFO - (blobuploader) - INFO - Done attempting. 15:40:32 INFO - (blobuploader) - INFO - Iteration through files over. 15:40:32 INFO - Return code: 0 15:40:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:40:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:40:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9842f39be2e2baad204027045de5588fa1fe6f8ac19ba035d3fe16a1c470bcf9c8a7c41391d829f6f7826196be9b95c339137e9ce18047c5c21c7e9ce5e02400", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8fdf7737ba61c258ee60c060bb9377dced8b29136bd75a142cb231a0c74eaab4a99785c00380b4fe351a1f5b727dc9a49ba5fbb85792955f0e17ab6a09492dcf"} 15:40:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:40:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:40:32 INFO - Contents: 15:40:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9842f39be2e2baad204027045de5588fa1fe6f8ac19ba035d3fe16a1c470bcf9c8a7c41391d829f6f7826196be9b95c339137e9ce18047c5c21c7e9ce5e02400", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8fdf7737ba61c258ee60c060bb9377dced8b29136bd75a142cb231a0c74eaab4a99785c00380b4fe351a1f5b727dc9a49ba5fbb85792955f0e17ab6a09492dcf"} 15:40:32 INFO - Running post-run listener: copy_logs_to_upload_dir 15:40:32 INFO - Copying logs to upload dir... 15:40:32 INFO - mkdir: /builds/slave/test/build/upload/logs 15:40:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.610474 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-15 15:40:32.184668) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 15:40:32.188251) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9842f39be2e2baad204027045de5588fa1fe6f8ac19ba035d3fe16a1c470bcf9c8a7c41391d829f6f7826196be9b95c339137e9ce18047c5c21c7e9ce5e02400", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8fdf7737ba61c258ee60c060bb9377dced8b29136bd75a142cb231a0c74eaab4a99785c00380b4fe351a1f5b727dc9a49ba5fbb85792955f0e17ab6a09492dcf"} build_url:https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/Dxue3fXLRASJg-5W3PYB5Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9842f39be2e2baad204027045de5588fa1fe6f8ac19ba035d3fe16a1c470bcf9c8a7c41391d829f6f7826196be9b95c339137e9ce18047c5c21c7e9ce5e02400", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8fdf7737ba61c258ee60c060bb9377dced8b29136bd75a142cb231a0c74eaab4a99785c00380b4fe351a1f5b727dc9a49ba5fbb85792955f0e17ab6a09492dcf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 15:40:32.217589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 15:40:32.217882) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452897356.324506-2008789520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004687 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 15:40:32.266900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 15:40:32.267172) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 15:40:32.267417) ========= ========= Total master_lag: 0.28 =========