builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1453127919.0 results: success (0) buildid: 20160118052322 builduid: 05a691b1ab204ed1a95dff71b76281b4 revision: a77b73c7723e1060993045fb31eb2f0a30473486 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.004694) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.005082) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.005366) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006445 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.031395) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.031718) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.045772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.046021) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.095253) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.095543) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.095892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.096187) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 06:38:39-- 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.3M=0s 2016-01-18 06:38:39 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153100 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.263686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.263964) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021086 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.314411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.314733) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a77b73c7723e1060993045fb31eb2f0a30473486 --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 a77b73c7723e1060993045fb31eb2f0a30473486 --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=2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 06:38:39,491 truncating revision to first 12 chars 2016-01-18 06:38:39,491 Setting DEBUG logging. 2016-01-18 06:38:39,491 attempt 1/10 2016-01-18 06:38:39,491 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a77b73c7723e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 06:38:39,769 unpacking tar archive at: mozilla-central-a77b73c7723e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596268 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.923708) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.924027) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003714 script_repo_revision: '%(revision)s' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.972676) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.972968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.984147) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.984422) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 06:38:39.984789) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-18 06:38:39.985059) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:38:40 INFO - MultiFileLogger online at 20160118 06:38:40 in /builds/slave/test 06:38:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:38:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:38:40 INFO - {'append_to_log': False, 06:38:40 INFO - 'base_work_dir': '/builds/slave/test', 06:38:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:38:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:38:40 INFO - 'branch': 'Firefox-Non-PGO', 06:38:40 INFO - 'buildbot_json_path': 'buildprops.json', 06:38:40 INFO - 'config_files': ('talos/linux_config.py',), 06:38:40 INFO - 'default_actions': ('clobber', 06:38:40 INFO - 'read-buildbot-config', 06:38:40 INFO - 'download-and-extract', 06:38:40 INFO - 'populate-webroot', 06:38:40 INFO - 'create-virtualenv', 06:38:40 INFO - 'install', 06:38:40 INFO - 'run-tests'), 06:38:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:38:40 INFO - 'download_minidump_stackwalk': True, 06:38:40 INFO - 'download_symbols': 'ondemand', 06:38:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:38:40 INFO - 'tooltool.py': '/tools/tooltool.py', 06:38:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:38:40 INFO - '/tools/misc-python/virtualenv.py')}, 06:38:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:38:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:38:40 INFO - 'installer_path': 'installer.exe', 06:38:40 INFO - 'log_level': 'info', 06:38:40 INFO - 'log_name': 'talos', 06:38:40 INFO - 'log_to_console': True, 06:38:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:38:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:38:40 INFO - 'opt_config_files': (), 06:38:40 INFO - 'pip_index': False, 06:38:40 INFO - 'sps_profile': False, 06:38:40 INFO - 'sps_profile_interval': 0, 06:38:40 INFO - 'suite': 'dromaeojs-e10s', 06:38:40 INFO - 'system_bits': '32', 06:38:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:38:40 INFO - 'title': 'talos-linux64-ix-012', 06:38:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:38:40 INFO - 'use_talos_json': True, 06:38:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:38:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:38:40 INFO - 'work_dir': 'build'} 06:38:40 INFO - ##### 06:38:40 INFO - ##### Running clobber step. 06:38:40 INFO - ##### 06:38:40 INFO - Running pre-action listener: _resource_record_pre_action 06:38:40 INFO - Running main action method: clobber 06:38:40 INFO - rmtree: /builds/slave/test/build 06:38:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:38:41 INFO - Running post-action listener: _resource_record_post_action 06:38:41 INFO - ##### 06:38:41 INFO - ##### Running read-buildbot-config step. 06:38:41 INFO - ##### 06:38:41 INFO - Running pre-action listener: _resource_record_pre_action 06:38:41 INFO - Running main action method: read_buildbot_config 06:38:41 INFO - Using buildbot properties: 06:38:41 INFO - { 06:38:41 INFO - "project": "", 06:38:41 INFO - "product": "firefox", 06:38:41 INFO - "script_repo_revision": "production", 06:38:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:38:41 INFO - "repository": "", 06:38:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:38:41 INFO - "buildid": "20160118052322", 06:38:41 INFO - "pgo_build": "False", 06:38:41 INFO - "basedir": "/builds/slave/test", 06:38:41 INFO - "buildnumber": 212, 06:38:41 INFO - "slavename": "talos-linux64-ix-012", 06:38:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:38:41 INFO - "platform": "ubuntu64_hw", 06:38:41 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:38:41 INFO - "branch": "mozilla-central", 06:38:41 INFO - "repo_path": "mozilla-central", 06:38:41 INFO - "revision": "a77b73c7723e1060993045fb31eb2f0a30473486", 06:38:41 INFO - "stage_platform": "linux64", 06:38:41 INFO - "builduid": "05a691b1ab204ed1a95dff71b76281b4", 06:38:41 INFO - "slavebuilddir": "test" 06:38:41 INFO - } 06:38:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:38:41 INFO - Running post-action listener: _resource_record_post_action 06:38:41 INFO - ##### 06:38:41 INFO - ##### Running download-and-extract step. 06:38:41 INFO - ##### 06:38:41 INFO - Running pre-action listener: _resource_record_pre_action 06:38:41 INFO - Running main action method: download_and_extract 06:38:41 INFO - mkdir: /builds/slave/test/build/tests 06:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:41 INFO - https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:38:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/test_packages.json 06:38:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/test_packages.json 06:38:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:38:41 INFO - Downloaded 1448 bytes. 06:38:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:38:41 INFO - Using the following test package requirements: 06:38:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:38:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:38:41 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:38:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:41 INFO - u'jsshell-linux-x86_64.zip'], 06:38:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:38:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:38:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:38:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:38:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:38:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:38:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:38:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:41 INFO - https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:38:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:38:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:38:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/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 06:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/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 06:38:44 INFO - Downloaded 21215629 bytes. 06:38:44 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'] 06:38:44 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 06:38:45 INFO - Return code: 0 06:38:45 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 06:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:45 INFO - https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:38:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:38:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:38:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/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 06:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/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 06:38:47 INFO - Downloaded 21215629 bytes. 06:38:47 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'] 06:38:47 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 06:38:49 INFO - Return code: 0 06:38: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')]} 06:38:49 INFO - https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:38:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:38:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:38:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/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 06:38:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/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 06:38:51 INFO - Downloaded 11132144 bytes. 06:38:51 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'] 06:38:51 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 06:38:51 INFO - Return code: 0 06:38:51 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')]} 06:38:51 INFO - https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:38:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:38:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:38:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/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 06:38:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWaHLEtDQy6xHkkCL7bO9g/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 06:38:56 INFO - Downloaded 54180371 bytes. 06:38:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:38:56 INFO - mkdir: /builds/slave/test/properties 06:38:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:38:56 INFO - Writing to file /builds/slave/test/properties/build_url 06:38:56 INFO - Contents: 06:38:56 INFO - build_url:https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:38:56 INFO - Running post-action listener: _resource_record_post_action 06:38:56 INFO - Running post-action listener: set_extra_try_arguments 06:38:56 INFO - ##### 06:38:56 INFO - ##### Running populate-webroot step. 06:38:56 INFO - ##### 06:38:56 INFO - Running pre-action listener: _resource_record_pre_action 06:38:56 INFO - Running main action method: populate_webroot 06:38:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:38:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:38:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:38:56 INFO - '--tppagecycles', 06:38:56 INFO - '7'], 06:38:56 INFO - 'tests': ['tsvgm']}}, 06:38:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:38:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:38:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:38:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:38:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:38:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:38:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:56 INFO - 'talos_options': ['--e10s'], 06:38:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:56 INFO - 'tests': ['damp', 'tps']}, 06:38:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:56 INFO - 'talos_options': ['--e10s'], 06:38:56 INFO - 'tests': ['damp', 'tps']}, 06:38:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:38:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:38:56 INFO - 'other': {'tests': ['a11yr', 06:38:56 INFO - 'ts_paint', 06:38:56 INFO - 'tpaint', 06:38:56 INFO - 'sessionrestore', 06:38:56 INFO - 'sessionrestore_no_auto_restore']}, 06:38:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:38:56 INFO - 'tests': ['a11yr', 06:38:56 INFO - 'ts_paint', 06:38:56 INFO - 'tpaint', 06:38:56 INFO - 'sessionrestore', 06:38:56 INFO - 'sessionrestore_no_auto_restore']}, 06:38:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:38:56 INFO - 'tests': ['a11yr', 06:38:56 INFO - 'ts_paint', 06:38:56 INFO - 'tpaint', 06:38:56 INFO - 'sessionrestore', 06:38:56 INFO - 'sessionrestore_no_auto_restore']}, 06:38:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:38:56 INFO - 'tests': ['a11yr', 06:38:56 INFO - 'ts_paint', 06:38:56 INFO - 'tpaint', 06:38:56 INFO - 'sessionrestore', 06:38:56 INFO - 'sessionrestore_no_auto_restore']}, 06:38:56 INFO - 'other_l64': {'tests': ['a11yr', 06:38:56 INFO - 'ts_paint', 06:38:56 INFO - 'tpaint', 06:38:56 INFO - 'sessionrestore', 06:38:56 INFO - 'sessionrestore_no_auto_restore']}, 06:38:56 INFO - 'other_nol64': {'tests': ['a11yr', 06:38:56 INFO - 'ts_paint', 06:38:56 INFO - 'tpaint', 06:38:56 INFO - 'sessionrestore', 06:38:56 INFO - 'sessionrestore_no_auto_restore']}, 06:38:56 INFO - 'svgr': {'tests': ['tsvgx', 06:38:56 INFO - 'tsvgr_opacity', 06:38:56 INFO - 'tart', 06:38:56 INFO - 'tscrollx', 06:38:56 INFO - 'cart']}, 06:38:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:38:56 INFO - 'tests': ['tsvgx', 06:38:56 INFO - 'tsvgr_opacity', 06:38:56 INFO - 'tart', 06:38:56 INFO - 'tscrollx', 06:38:56 INFO - 'cart']}, 06:38:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:56 INFO - 'tests': ['tp5o']}, 06:38:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:56 INFO - 'talos_options': ['--e10s'], 06:38:56 INFO - 'tests': ['tp5o']}, 06:38:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:56 INFO - 'talos_options': ['--xperf_path', 06:38:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:56 INFO - 'tests': ['tp5n']}, 06:38:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:56 INFO - 'talos_options': ['--e10s', 06:38:56 INFO - '--xperf_path', 06:38:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:56 INFO - 'tests': ['tp5n']}}, 06:38:56 INFO - 'talos.zip': {'path': '', 06:38:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:38:56 INFO - Running post-action listener: _resource_record_post_action 06:38:56 INFO - ##### 06:38:56 INFO - ##### Running create-virtualenv step. 06:38:56 INFO - ##### 06:38:56 INFO - Running pre-action listener: _resource_record_pre_action 06:38:56 INFO - Running main action method: create_virtualenv 06:38:56 INFO - Creating virtualenv /builds/slave/test/build/venv 06:38:56 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 06:38:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:38:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:38:56 INFO - Using real prefix '/usr' 06:38:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:38:57 INFO - Installing distribute.............................................................................................................................................................................................done. 06:38:59 INFO - Installing pip.................done. 06:38:59 INFO - Return code: 0 06:38:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:59 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 0x7ffc88b0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1169dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fc3d0>, '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 0x1167ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1168360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', '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 06:38:59 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 06:38:59 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 06:38:59 INFO - Using env: {'DISPLAY': ':0', 06:38:59 INFO - 'HOME': '/home/cltbld', 06:38:59 INFO - 'LANG': 'en_US.UTF-8', 06:38:59 INFO - 'LANGUAGE': 'en_US:en', 06:38:59 INFO - 'LOGNAME': 'cltbld', 06:38:59 INFO - 'MAIL': '/var/mail/cltbld', 06:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:59 INFO - 'MOZ_NO_REMOTE': '1', 06:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:59 INFO - 'NO_EM_RESTART': '1', 06:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:59 INFO - 'PWD': '/builds/slave/test', 06:38:59 INFO - 'SHELL': '/bin/bash', 06:38:59 INFO - 'SHLVL': '1', 06:38:59 INFO - 'TERM': 'linux', 06:38:59 INFO - 'TMOUT': '86400', 06:38:59 INFO - 'USER': 'cltbld', 06:38:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', 06:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:59 INFO - '_': '/tools/buildbot/bin/python'} 06:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:59 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 06:38:59 INFO - Cleaning up... 06:38:59 INFO - Return code: 0 06:38:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:59 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 0x7ffc88b0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1169dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fc3d0>, '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 0x1167ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1168360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', '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 06:38:59 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 06:38:59 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 06:38:59 INFO - Using env: {'DISPLAY': ':0', 06:38:59 INFO - 'HOME': '/home/cltbld', 06:38:59 INFO - 'LANG': 'en_US.UTF-8', 06:38:59 INFO - 'LANGUAGE': 'en_US:en', 06:38:59 INFO - 'LOGNAME': 'cltbld', 06:38:59 INFO - 'MAIL': '/var/mail/cltbld', 06:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:59 INFO - 'MOZ_NO_REMOTE': '1', 06:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:59 INFO - 'NO_EM_RESTART': '1', 06:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:59 INFO - 'PWD': '/builds/slave/test', 06:38:59 INFO - 'SHELL': '/bin/bash', 06:38:59 INFO - 'SHLVL': '1', 06:38:59 INFO - 'TERM': 'linux', 06:38:59 INFO - 'TMOUT': '86400', 06:38:59 INFO - 'USER': 'cltbld', 06:38:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', 06:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:59 INFO - '_': '/tools/buildbot/bin/python'} 06:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:59 INFO - Downloading/unpacking psutil>=0.7.1 06:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:39:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:39:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:01 INFO - Installing collected packages: psutil 06:39:01 INFO - Running setup.py install for psutil 06:39:01 INFO - building 'psutil._psutil_linux' extension 06:39:01 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 06:39:01 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 06:39:01 INFO - building 'psutil._psutil_posix' extension 06:39:01 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 06:39:01 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 06:39:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:01 INFO - Successfully installed psutil 06:39:01 INFO - Cleaning up... 06:39:01 INFO - Return code: 0 06:39:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ffc88b0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1169dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fc3d0>, '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 0x1167ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1168360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', '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 06:39:01 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 06:39:01 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 06:39:01 INFO - Using env: {'DISPLAY': ':0', 06:39:01 INFO - 'HOME': '/home/cltbld', 06:39:01 INFO - 'LANG': 'en_US.UTF-8', 06:39:01 INFO - 'LANGUAGE': 'en_US:en', 06:39:01 INFO - 'LOGNAME': 'cltbld', 06:39:01 INFO - 'MAIL': '/var/mail/cltbld', 06:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:01 INFO - 'MOZ_NO_REMOTE': '1', 06:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:01 INFO - 'NO_EM_RESTART': '1', 06:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:01 INFO - 'PWD': '/builds/slave/test', 06:39:01 INFO - 'SHELL': '/bin/bash', 06:39:01 INFO - 'SHLVL': '1', 06:39:01 INFO - 'TERM': 'linux', 06:39:01 INFO - 'TMOUT': '86400', 06:39:01 INFO - 'USER': 'cltbld', 06:39:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', 06:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:01 INFO - '_': '/tools/buildbot/bin/python'} 06:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:39:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:39:03 INFO - Installing collected packages: mozsystemmonitor 06:39:03 INFO - Running setup.py install for mozsystemmonitor 06:39:03 INFO - Successfully installed mozsystemmonitor 06:39:03 INFO - Cleaning up... 06:39:04 INFO - Return code: 0 06:39:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ffc88b0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1169dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fc3d0>, '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 0x1167ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1168360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', '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 06:39:04 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 06:39:04 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 06:39:04 INFO - Using env: {'DISPLAY': ':0', 06:39:04 INFO - 'HOME': '/home/cltbld', 06:39:04 INFO - 'LANG': 'en_US.UTF-8', 06:39:04 INFO - 'LANGUAGE': 'en_US:en', 06:39:04 INFO - 'LOGNAME': 'cltbld', 06:39:04 INFO - 'MAIL': '/var/mail/cltbld', 06:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:04 INFO - 'MOZ_NO_REMOTE': '1', 06:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:04 INFO - 'NO_EM_RESTART': '1', 06:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:04 INFO - 'PWD': '/builds/slave/test', 06:39:04 INFO - 'SHELL': '/bin/bash', 06:39:04 INFO - 'SHLVL': '1', 06:39:04 INFO - 'TERM': 'linux', 06:39:04 INFO - 'TMOUT': '86400', 06:39:04 INFO - 'USER': 'cltbld', 06:39:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', 06:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:04 INFO - '_': '/tools/buildbot/bin/python'} 06:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:04 INFO - Downloading/unpacking blobuploader==1.2.4 06:39:04 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 06:39:04 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 06:39:04 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 06:39:04 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 06:39:04 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 06:39:04 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 06:39:05 INFO - Downloading blobuploader-1.2.4.tar.gz 06:39:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:39:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:39:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:06 INFO - Downloading docopt-0.6.1.tar.gz 06:39:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:39:06 INFO - Installing collected packages: blobuploader, requests, docopt 06:39:06 INFO - Running setup.py install for blobuploader 06:39:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:39:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:39:06 INFO - Running setup.py install for requests 06:39:07 INFO - Running setup.py install for docopt 06:39:07 INFO - Successfully installed blobuploader requests docopt 06:39:07 INFO - Cleaning up... 06:39:07 INFO - Return code: 0 06:39:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:07 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 0x7ffc88b0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1169dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fc3d0>, '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 0x1167ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1168360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', '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 06:39:07 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 06:39:07 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 06:39:07 INFO - Using env: {'DISPLAY': ':0', 06:39:07 INFO - 'HOME': '/home/cltbld', 06:39:07 INFO - 'LANG': 'en_US.UTF-8', 06:39:07 INFO - 'LANGUAGE': 'en_US:en', 06:39:07 INFO - 'LOGNAME': 'cltbld', 06:39:07 INFO - 'MAIL': '/var/mail/cltbld', 06:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:07 INFO - 'MOZ_NO_REMOTE': '1', 06:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:07 INFO - 'NO_EM_RESTART': '1', 06:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:07 INFO - 'PWD': '/builds/slave/test', 06:39:07 INFO - 'SHELL': '/bin/bash', 06:39:07 INFO - 'SHLVL': '1', 06:39:07 INFO - 'TERM': 'linux', 06:39:07 INFO - 'TMOUT': '86400', 06:39:07 INFO - 'USER': 'cltbld', 06:39:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', 06:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:07 INFO - '_': '/tools/buildbot/bin/python'} 06:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:07 INFO - Running setup.py (path:/tmp/pip-G2N8UA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:07 INFO - Running setup.py (path:/tmp/pip-LD2dOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:07 INFO - Running setup.py (path:/tmp/pip-jUti2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:07 INFO - Running setup.py (path:/tmp/pip-n1NQlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:07 INFO - Running setup.py (path:/tmp/pip-qJjP2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:07 INFO - Running setup.py (path:/tmp/pip-a3r6mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:07 INFO - Running setup.py (path:/tmp/pip-6bqeD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:07 INFO - Running setup.py (path:/tmp/pip-2o2VdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:08 INFO - Running setup.py (path:/tmp/pip-_0VRbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:08 INFO - Running setup.py (path:/tmp/pip-UNHhDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:08 INFO - Running setup.py (path:/tmp/pip-N1BBrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:08 INFO - Running setup.py (path:/tmp/pip-dXou4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:08 INFO - Running setup.py (path:/tmp/pip-eyT0GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:08 INFO - Running setup.py (path:/tmp/pip-Pou9C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:08 INFO - Running setup.py (path:/tmp/pip-vTHbnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:08 INFO - Running setup.py (path:/tmp/pip-9GfNNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:08 INFO - Running setup.py (path:/tmp/pip-G0tYsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:39:08 INFO - Running setup.py install for manifestparser 06:39:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:39:08 INFO - Running setup.py install for mozcrash 06:39:08 INFO - Running setup.py install for mozdebug 06:39:08 INFO - Running setup.py install for mozdevice 06:39:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:39:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:39:09 INFO - Running setup.py install for mozfile 06:39:09 INFO - Running setup.py install for mozhttpd 06:39:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:39:09 INFO - Running setup.py install for mozinfo 06:39:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:39:09 INFO - Running setup.py install for mozInstall 06:39:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:39:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:39:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:39:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:39:09 INFO - Running setup.py install for mozleak 06:39:09 INFO - Running setup.py install for mozlog 06:39:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:39:09 INFO - Running setup.py install for moznetwork 06:39:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:39:09 INFO - Running setup.py install for mozprocess 06:39:09 INFO - Running setup.py install for mozprofile 06:39:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:39:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:39:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:39:10 INFO - Running setup.py install for mozrunner 06:39:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:39:10 INFO - Running setup.py install for mozscreenshot 06:39:10 INFO - Running setup.py install for moztest 06:39:10 INFO - Running setup.py install for mozversion 06:39:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:39:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:39:10 INFO - Cleaning up... 06:39:10 INFO - Return code: 0 06:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:10 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')]} 06:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:10 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')]} 06:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:10 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 0x7ffc88b0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1169dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fc3d0>, '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 0x1167ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1168360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', '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 06:39:10 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 06:39:10 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 06:39:10 INFO - Using env: {'DISPLAY': ':0', 06:39:10 INFO - 'HOME': '/home/cltbld', 06:39:10 INFO - 'LANG': 'en_US.UTF-8', 06:39:10 INFO - 'LANGUAGE': 'en_US:en', 06:39:10 INFO - 'LOGNAME': 'cltbld', 06:39:10 INFO - 'MAIL': '/var/mail/cltbld', 06:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:10 INFO - 'MOZ_NO_REMOTE': '1', 06:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:10 INFO - 'NO_EM_RESTART': '1', 06:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:10 INFO - 'PWD': '/builds/slave/test', 06:39:10 INFO - 'SHELL': '/bin/bash', 06:39:10 INFO - 'SHLVL': '1', 06:39:10 INFO - 'TERM': 'linux', 06:39:10 INFO - 'TMOUT': '86400', 06:39:10 INFO - 'USER': 'cltbld', 06:39:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', 06:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:10 INFO - '_': '/tools/buildbot/bin/python'} 06:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:10 INFO - Running setup.py (path:/tmp/pip-mpYIt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:10 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)) 06:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:10 INFO - Running setup.py (path:/tmp/pip-dpf09n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:10 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)) 06:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:10 INFO - Running setup.py (path:/tmp/pip-JfVocl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:10 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)) 06:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:10 INFO - Running setup.py (path:/tmp/pip-5GgJo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:11 INFO - Running setup.py (path:/tmp/pip-dNStdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:11 INFO - Running setup.py (path:/tmp/pip-p19LZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:11 INFO - Running setup.py (path:/tmp/pip-DcTygb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:11 INFO - Running setup.py (path:/tmp/pip-5JrXxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:11 INFO - Running setup.py (path:/tmp/pip-_Nr5s8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:11 INFO - Running setup.py (path:/tmp/pip-gxPWiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:11 INFO - Running setup.py (path:/tmp/pip-ZbIp5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:11 INFO - Running setup.py (path:/tmp/pip-O05WsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:11 INFO - Running setup.py (path:/tmp/pip-SDCagA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:11 INFO - Running setup.py (path:/tmp/pip-BFhlDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:11 INFO - Running setup.py (path:/tmp/pip-CtW99Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:11 INFO - Running setup.py (path:/tmp/pip-MYwowK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:11 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)) 06:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:11 INFO - Running setup.py (path:/tmp/pip-pxCqPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:11 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)) 06:39:11 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)) 06:39:11 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)) 06:39:11 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)) 06:39:11 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)) 06:39:11 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)) 06:39:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:39:11 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 06:39:11 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 06:39:11 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 06:39:11 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 06:39:11 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 06:39:11 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 06:39:13 INFO - Downloading blessings-1.5.1.tar.gz 06:39:13 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 06:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:39:13 INFO - Installing collected packages: blessings 06:39:13 INFO - Running setup.py install for blessings 06:39:13 INFO - Successfully installed blessings 06:39:13 INFO - Cleaning up... 06:39:13 INFO - Return code: 0 06:39:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:14 INFO - Reading from file tmpfile_stdout 06:39:14 INFO - Current package versions: 06:39:14 INFO - argparse == 1.2.1 06:39:14 INFO - blessings == 1.5.1 06:39:14 INFO - blobuploader == 1.2.4 06:39:14 INFO - docopt == 0.6.1 06:39:14 INFO - manifestparser == 1.1 06:39:14 INFO - mozInstall == 1.12 06:39:14 INFO - mozcrash == 0.16 06:39:14 INFO - mozdebug == 0.1 06:39:14 INFO - mozdevice == 0.48 06:39:14 INFO - mozfile == 1.2 06:39:14 INFO - mozhttpd == 0.7 06:39:14 INFO - mozinfo == 0.9 06:39:14 INFO - mozleak == 0.1 06:39:14 INFO - mozlog == 3.1 06:39:14 INFO - moznetwork == 0.27 06:39:14 INFO - mozprocess == 0.22 06:39:14 INFO - mozprofile == 0.28 06:39:14 INFO - mozrunner == 6.11 06:39:14 INFO - mozscreenshot == 0.1 06:39:14 INFO - mozsystemmonitor == 0.0 06:39:14 INFO - moztest == 0.7 06:39:14 INFO - mozversion == 1.4 06:39:14 INFO - psutil == 3.1.1 06:39:14 INFO - requests == 1.2.3 06:39:14 INFO - wsgiref == 0.1.2 06:39:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7ffc88b0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1169dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fc3d0>, '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 0x1167ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1168360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', '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 06:39:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 06:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 06:39:14 INFO - Using env: {'DISPLAY': ':0', 06:39:14 INFO - 'HOME': '/home/cltbld', 06:39:14 INFO - 'LANG': 'en_US.UTF-8', 06:39:14 INFO - 'LANGUAGE': 'en_US:en', 06:39:14 INFO - 'LOGNAME': 'cltbld', 06:39:14 INFO - 'MAIL': '/var/mail/cltbld', 06:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:14 INFO - 'MOZ_NO_REMOTE': '1', 06:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:14 INFO - 'NO_EM_RESTART': '1', 06:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:14 INFO - 'PWD': '/builds/slave/test', 06:39:14 INFO - 'SHELL': '/bin/bash', 06:39:14 INFO - 'SHLVL': '1', 06:39:14 INFO - 'TERM': 'linux', 06:39:14 INFO - 'TMOUT': '86400', 06:39:14 INFO - 'USER': 'cltbld', 06:39:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', 06:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:14 INFO - '_': '/tools/buildbot/bin/python'} 06:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:14 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)) 06:39:14 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)) 06:39:14 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)) 06:39:14 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)) 06:39:14 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)) 06:39:14 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)) 06:39:14 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)) 06:39:14 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)) 06:39:14 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)) 06:39:14 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)) 06:39:14 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)) 06:39:14 INFO - Cleaning up... 06:39:14 INFO - Return code: 0 06:39:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ffc88b0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1169dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fc3d0>, '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 0x1167ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1168360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', '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 06:39:14 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 06:39:14 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 06:39:14 INFO - Using env: {'DISPLAY': ':0', 06:39:14 INFO - 'HOME': '/home/cltbld', 06:39:14 INFO - 'LANG': 'en_US.UTF-8', 06:39:14 INFO - 'LANGUAGE': 'en_US:en', 06:39:14 INFO - 'LOGNAME': 'cltbld', 06:39:14 INFO - 'MAIL': '/var/mail/cltbld', 06:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:14 INFO - 'MOZ_NO_REMOTE': '1', 06:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:14 INFO - 'NO_EM_RESTART': '1', 06:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:14 INFO - 'PWD': '/builds/slave/test', 06:39:14 INFO - 'SHELL': '/bin/bash', 06:39:14 INFO - 'SHLVL': '1', 06:39:14 INFO - 'TERM': 'linux', 06:39:14 INFO - 'TMOUT': '86400', 06:39:14 INFO - 'USER': 'cltbld', 06:39:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', 06:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:14 INFO - '_': '/tools/buildbot/bin/python'} 06:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:14 INFO - Downloading/unpacking jsonschema 06:39:14 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 06:39:14 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 06:39:14 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 06:39:14 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 06:39:14 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 06:39:14 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 06:39:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:39:16 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 06:39:16 INFO - Downloading/unpacking functools32 (from jsonschema) 06:39:16 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 06:39:16 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 06:39:16 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 06:39:16 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 06:39:16 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 06:39:16 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 06:39:16 INFO - Downloading functools32-3.2.3-2.tar.gz 06:39:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:39:16 INFO - warning: no files found matching '*.txt' 06:39:16 INFO - no previously-included directories found matching 'build' 06:39:16 INFO - no previously-included directories found matching 'dist' 06:39:16 INFO - no previously-included directories found matching '.git*' 06:39:16 INFO - Installing collected packages: jsonschema, functools32 06:39:16 INFO - Running setup.py install for functools32 06:39:16 INFO - warning: no files found matching '*.txt' 06:39:16 INFO - no previously-included directories found matching 'build' 06:39:16 INFO - no previously-included directories found matching 'dist' 06:39:16 INFO - no previously-included directories found matching '.git*' 06:39:16 INFO - Successfully installed jsonschema functools32 06:39:16 INFO - Cleaning up... 06:39:16 INFO - Return code: 0 06:39:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:39:16 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')]} 06:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:16 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')]} 06:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:16 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 0x7ffc88b0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1169dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fc3d0>, '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 0x1167ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1168360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', '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 06:39:16 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 06:39:16 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 06:39:16 INFO - Using env: {'DISPLAY': ':0', 06:39:16 INFO - 'HOME': '/home/cltbld', 06:39:16 INFO - 'LANG': 'en_US.UTF-8', 06:39:16 INFO - 'LANGUAGE': 'en_US:en', 06:39:16 INFO - 'LOGNAME': 'cltbld', 06:39:16 INFO - 'MAIL': '/var/mail/cltbld', 06:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:16 INFO - 'MOZ_NO_REMOTE': '1', 06:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:16 INFO - 'NO_EM_RESTART': '1', 06:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:16 INFO - 'PWD': '/builds/slave/test', 06:39:16 INFO - 'SHELL': '/bin/bash', 06:39:16 INFO - 'SHLVL': '1', 06:39:16 INFO - 'TERM': 'linux', 06:39:16 INFO - 'TMOUT': '86400', 06:39:16 INFO - 'USER': 'cltbld', 06:39:16 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', 06:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:16 INFO - '_': '/tools/buildbot/bin/python'} 06:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:16 INFO - Downloading/unpacking flake8 06:39:16 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 06:39:16 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 06:39:16 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 06:39:16 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 06:39:16 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 06:39:16 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 06:39:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:39:18 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 06:39:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:39:18 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 06:39:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:19 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 06:39:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:39:19 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 06:39:19 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 06:39:19 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 06:39:19 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 06:39:19 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 06:39:19 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 06:39:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:39:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:39:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:39:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:39:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:39:20 INFO - no previously-included directories found matching 'docs/_build' 06:39:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:39:21 INFO - Running setup.py install for pep8 06:39:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:39:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:39:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:39:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:39:21 INFO - no previously-included directories found matching 'docs/_build' 06:39:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:39:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:39:21 INFO - Cleaning up... 06:39:21 INFO - Return code: 0 06:39:21 INFO - Running post-action listener: _resource_record_post_action 06:39:21 INFO - Running post-action listener: _start_resource_monitoring 06:39:21 INFO - Starting resource monitoring. 06:39:21 INFO - ##### 06:39:21 INFO - ##### Running install step. 06:39:21 INFO - ##### 06:39:21 INFO - Running pre-action listener: _resource_record_pre_action 06:39:21 INFO - Running main action method: install 06:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:21 INFO - Reading from file tmpfile_stdout 06:39:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:39:21 INFO - Reading from file tmpfile_stdout 06:39:21 INFO - Output received: 06:39:21 INFO - Usage: mozinstall [options] installer 06:39:21 INFO - Options: 06:39:21 INFO - -h, --help show this help message and exit 06:39:21 INFO - -d DEST, --destination=DEST 06:39:21 INFO - Directory to install application into. [default: 06:39:21 INFO - "/builds/slave/test"] 06:39:21 INFO - --app=APP Application being installed. [default: firefox] 06:39:21 INFO - mkdir: /builds/slave/test/build/application 06:39:21 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'] 06:39:21 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 06:39:37 INFO - Reading from file tmpfile_stdout 06:39:37 INFO - Output received: 06:39:37 INFO - /builds/slave/test/build/application/firefox/firefox 06:39:37 INFO - Running post-action listener: _resource_record_post_action 06:39:37 INFO - ##### 06:39:37 INFO - ##### Running run-tests step. 06:39:37 INFO - ##### 06:39:37 INFO - Running pre-action listener: _resource_record_pre_action 06:39:37 INFO - Running main action method: run_tests 06:39:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:39:37 INFO - Python 2.7.3 06:39:37 INFO - Return code: 0 06:39:37 INFO - grabbing minidump binary from tooltool 06:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:37 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 0x11fc3d0>, '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 0x1167ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1168360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:39:37 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 06:39:37 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 06:39:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:39:37 INFO - Return code: 0 06:39:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:39:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:39:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:39:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:39:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:39:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:39:38 INFO - Return code: 0 06:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:39:38 INFO - Using env: {'DISPLAY': ':0', 06:39:38 INFO - 'HOME': '/home/cltbld', 06:39:38 INFO - 'LANG': 'en_US.UTF-8', 06:39:38 INFO - 'LANGUAGE': 'en_US:en', 06:39:38 INFO - 'LOGNAME': 'cltbld', 06:39:38 INFO - 'MAIL': '/var/mail/cltbld', 06:39:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:39:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:38 INFO - 'MOZ_NO_REMOTE': '1', 06:39:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:38 INFO - 'NO_EM_RESTART': '1', 06:39:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:38 INFO - 'PWD': '/builds/slave/test', 06:39:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:39:38 INFO - 'SHELL': '/bin/bash', 06:39:38 INFO - 'SHLVL': '1', 06:39:38 INFO - 'TERM': 'linux', 06:39:38 INFO - 'TMOUT': '86400', 06:39:38 INFO - 'USER': 'cltbld', 06:39:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733', 06:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:38 INFO - '_': '/tools/buildbot/bin/python'} 06:39:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:39:38 INFO - mozversion application_buildid: 20160118052322 06:39:38 INFO - mozversion application_changeset: a77b73c7723e1060993045fb31eb2f0a30473486 06:39:38 INFO - mozversion application_display_name: Nightly 06:39:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:39:38 INFO - mozversion application_name: Firefox 06:39:38 INFO - mozversion application_remotingname: firefox 06:39:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:39:38 INFO - mozversion application_vendor: Mozilla 06:39:38 INFO - mozversion application_version: 46.0a1 06:39:38 INFO - mozversion platform_buildid: 20160118052322 06:39:38 INFO - mozversion platform_changeset: a77b73c7723e1060993045fb31eb2f0a30473486 06:39:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:39:38 INFO - mozversion platform_version: 46.0a1 06:39:38 INFO - using testdate: 1453127978 06:39:38 INFO - actual date: 1453127978 06:39:38 INFO - starting webserver on 'localhost:45786' 06:39:38 INFO - SUITE-START | Running 3 tests 06:39:38 INFO - TEST-START | dromaeo_css 06:39:38 INFO - operating with platform_type : linux_ 06:39:38 INFO - Initialising browser for dromaeo_css test... 06:39:38 INFO - TEST-INFO | started process 23540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7xM9uA/profile http://localhost:45786/getInfo.html) 06:39:41 INFO - PROCESS | 23540 | 06:39:41 INFO - PROCESS | 23540 | (process:23624): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:39:42 INFO - PROCESS | 23540 | __metrics Screen width/height:1600/1200 06:39:42 INFO - PROCESS | 23540 | colorDepth:24 06:39:42 INFO - PROCESS | 23540 | Browser inner width/height: 1024/697 06:39:42 INFO - PROCESS | 23540 | __metrics 06:39:42 INFO - PROCESS | 23540 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:39:43 INFO - TEST-INFO | 23540: exit 0 06:39:43 INFO - Browser initialized. 06:39:43 INFO - Running cycle 1/1 for dromaeo_css test... 06:39:43 INFO - TEST-INFO | started process 23672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7xM9uA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:39:44 INFO - PROCESS | 23672 | -- checkerboarding starts below -- 06:39:44 INFO - PROCESS | 23672 | RENDERTRACE 0.042018 rect red 0 0 10 10 // viewport 06:39:44 INFO - PROCESS | 23672 | RENDERTRACE 1.14551 rect red 0 0 10 10 // viewport 06:39:44 INFO - PROCESS | 23672 | RENDERTRACE 16.0969 rect red 0 0 10 10 // viewport 06:39:44 INFO - PROCESS | 23672 | RENDERTRACE 27.4974 rect brown 0 0 10 10 // page 06:39:44 INFO - PROCESS | 23672 | RENDERTRACE 27.513 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 06:39:44 INFO - PROCESS | 23672 | Checkerboarded for 3 frames (31.3192 ms), 100 peak, 1608 severity. 06:39:45 INFO - PROCESS | 23672 | 06:39:45 INFO - PROCESS | 23672 | (process:23729): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:39:55 INFO - PROCESS | 23672 | RSS: Main: 150577152 06:39:55 INFO - PROCESS | 23672 | 06:40:45 INFO - PROCESS | 23672 | 1453128045326 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] 06:42:56 INFO - PROCESS | 23672 | Cycle 1(1): loaded http://localhost:45786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45786/tests/dromaeo/cssquery-ext.html) 06:42:57 INFO - PROCESS | 23672 | RSS: Main: 153075712 06:42:57 INFO - PROCESS | 23672 | 06:45:59 INFO - PROCESS | 23672 | Cycle 1(1): loaded http://localhost:45786/tests/dromaeo/cssquery-ext.html (next: http://localhost:45786/tests/dromaeo/cssquery-jquery.html) 06:46:00 INFO - PROCESS | 23672 | RSS: Main: 153645056 06:46:00 INFO - PROCESS | 23672 | 06:49:02 INFO - PROCESS | 23672 | Cycle 1(1): loaded http://localhost:45786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45786/tests/dromaeo/cssquery-mootools.html) 06:49:02 INFO - PROCESS | 23672 | RSS: Main: 150835200 06:49:02 INFO - PROCESS | 23672 | 06:52:04 INFO - PROCESS | 23672 | Cycle 1(1): loaded http://localhost:45786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45786/tests/dromaeo/cssquery-prototype.html) 06:52:05 INFO - PROCESS | 23672 | RSS: Main: 150794240 06:52:05 INFO - PROCESS | 23672 | 06:55:07 INFO - PROCESS | 23672 | Cycle 1(1): loaded http://localhost:45786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45786/tests/dromaeo/cssquery-yui.html) 06:55:08 INFO - PROCESS | 23672 | RSS: Main: 151560192 06:55:08 INFO - PROCESS | 23672 | 06:58:10 INFO - PROCESS | 23672 | Cycle 1(1): loaded http://localhost:45786/tests/dromaeo/cssquery-yui.html (next: http://localhost:45786/tests/dromaeo/cssquery-dojo.html) 06:58:11 INFO - PROCESS | 23672 | RSS: Main: 152834048 06:58:11 INFO - PROCESS | 23672 | 06:58:11 INFO - PROCESS | 23672 | __start_tp_report 06:58:11 INFO - PROCESS | 23672 | _x_x_mozilla_page_load 06:58:11 INFO - PROCESS | 23672 | _x_x_mozilla_page_load_details 06:58:11 INFO - PROCESS | 23672 | |i|pagename|runs| 06:58:11 INFO - PROCESS | 23672 | |0;dojo.html;2591.9222423327296;2598.0906682661057;2632.4340266842637;2642.854642994636;2661.21494159223;4340.414044104045;4484.66365022623;4486.484054333752;4504.099180163968;4534.773261336933;4445.911081778362;4506.707064040835;4527.977360113195;4562.771861406933;4624.6300295976325;3993.3011722948513;4169.791510424474;4244.575542445762;4258.339957306623;4304.655627549804;4160;4184.581541845821;4227.640650544708;4252.8511502097435;4268.6798490113215;4038.9192216155807;4140.399642051885;4141.130362623852;4179.582041795827;4259.51015633203;4155.293600087993;4162.729422587522;4182.2890108681595;4191.538930717618;4194.81123349447;4031.5162180538523;4140.399642051885;4169.624733773975;4177.895552611179;4182.038131229804;4347.30443129101;4462.4645042594775;4502.4371953505815;4511.6165125964335;4554.931676024862;4816.049529705895;4824.951750482485;4862.5380588844355;4862.610991120702;4905.4358748744;4723.929141062852;4782.976085119552;4886.51134886512;4898.804047838083;4923.606111511106;4459.531749166324;4539.114872599811;4540.182767101887;4545.909081818345;4569.862904112882;4847.7638202258195;4864.635152363587;4875.658703890765;4905.656604037683;4926.285688575136;4621.514740952219;4698.083873644675;4710.8351207707565;4718.079974405026;4756.167670657621;4792.95207047932;4806.567408933212;4809.735464549413;4817.1810792164715;4874.512548745168;4681.859544213679;4746.5490778376;4755.738434386073;4760.381150450488;4775.2359622460235;4633.467151277646;4732.574068333866;4738.19450693383;4740.14677358072;4815;4091.447654566655;4114.115465175002;4114.979425102855;4139.482564679415;4147.91704165915;3638.0541059324237;3642.85428582859;3645.872394466181;3647.452882067711;3683.2633473305445;4091.7954102294766;4173.019340454991;4187.497500299984;4191.392248124066;4240.469941257343;4805.27920811881;4819.49395313494;4856.587190088811;4865.172920603506;4902.1176188285735;4226.197022565702;4233.534311225762;4236.639885609758;4239.533651298355;4282.978585107055;4282.507511636201;4356.281213599784;4357.760323182255;4366.607005369468;4402.757848318309;4536.637069034469;4539.364488971547;4583.449986001701;4647.837325693585;4652.464966528893;4841.8547443576745;4854.053459575349;4856.1987272099705;4894.853154405374;4931.72875491837;4578.427696537933;4592.954070459253;4623.53764623535;4632.467266264288;4658.068386322817;4649.930251046169;4731.219348807408;4735.100330937111;4780.067886762048;4785.665003449864;4830;4830.396200474941;4838.177509823268;4849.175640141114;4878.80484780619;4588.242939914877;4649.139909116824;4654.697444666086;4662.813487460464;4699.342092107039;4623.69945953512;4686.695364801277;4732.313814496947;4746.098241334135;4751.097291514601;4577.748223847587;4587.151376995266;4605.148047611203;4629.120467111238;4667.9766601166775;4622.445306563234;4733.148033354029;4804.8318308859025;4808.374911261513;4821.734804585782;4634.9536504634525;4645.442546894395;4652.837150699709;4655.4413470382415;4729.645276604199 06:58:11 INFO - PROCESS | 23672 | |1;ext.html;514.6731825290943;527.9419263880974;543.6058857328435;543.6629289840298;550.6806052489557;32922.341553168924;33008.834955825216;33165;33322.66677333226;33392.33215335692;35756.64243357565;36277.63722362782;36313.2737345253;36355;36371.27257454849;7664.463487555873;7836.2947334739865;7877.645505952246;7879.960600196991;7889.8027549311155;7779.260970207822;8014.599270036504;8031.277185053344;8035.357171426301;8040.035195776515;7969.481983671043;8007.839843203133;8056.315213206855;8063.879041814348;8074.555899425529;7935.365170786324;7976.6809327626825;8007.599620019005;8029.036515618105;8065.233802788696;7788.727394541221;7930.841383172362;7933.286004259644;7963.761087167394;7983.560904150269;36219.63780362189;36290.45564316538;36502.269954601026;36532.45201321982;36603.08492287688;2892.24801551596;2933.5306350983956;2958.7632989361014;2959.156640357488;2971.509700899349;28409;28583.85708071467;28748.712512874812;29015.85492072526;29019.41961160786;3402;3453;3499.7900125992523;3549.6450354964554;3591.425371940477;157716;159327.2033639836;159438.20280898636;159462;159984;46396.53603463922;47168.5283147171;54375.45624543783;54563.727181363836;54707;56967.71516142393;57753.422465774805;58203.41796582065;58230.7088464555;58234.4176558229;14191.219482928538;14281.285935703174;14334.569962901129;14506.564803055926;14509.419623215164;10929.672109836718;11008.064314533354;11031.889681103246;11052;11131.72170695739;18619.720704189447;18741.7188742169;19135.330263440992;19154.616907662046;19174.712379314322;6893.75871844483;7187.7843664690145;7191.101112360955;7201.387882030086;7301.37938275242;899.1772528136681;915.9221466175317;937.7936853892132;942.0955882353018;983.7098056073476;25372;26191.821368038483;26229.606555901675;26451.206463806117;26596.468070638864;942.3827393057559;966.5650457294246;977.4819345746765;1051.3271506236015;1059.4014381874217;13157.934210329078;13318.800217996737;13803.792943105862;14535.636609084857;14769.40922363115;257893;260598;262338;262943;262949;45474;45925.31112033322;45929.540704592524;45958.54041459609;45963.31055034177;1184.5084290019545;1197.2696655040418;1219.945102470391;1229.569650622275;1246.3643541793751;25115.87442062778;26472.8676356617;26685.19944401671;27045.45909081768;27283.72716272812;36156.63843361638;36531.173441328356;36555;36578;36605.81697091497;158319.20840395725;160131;160614;161423;161441;25309.493810123327;28154.577681334387;28470.145895623165;28661;28744.281392965342;32796.34407311793;33185.66814331922;33434.164145896546;33573.83213083919;33574.83212583922;28342.149735507966;28933;29003;29023.7097629021;29459.705402945696;30514.389712205186;31420.371592567564;31761.682383176798;32474.35051299008;32503;31507.842460788466;31721.5241771369;31839.6816031846;32028.5195722069;32103.357932841678;27526.17421477359;28584.955968322975;29360.706392935797;29381.11856644304;29450.852745736134;22928;23544.764552354944;23566.528669426174;23770.643440348755;23778 06:58:11 INFO - PROCESS | 23672 | |2;jquery.html;340.1462329552823;340.61340378670207;343.86589230200224;345.51282691405106;348.5695166469408;11767.529298828058;12245.938770306158;13813.37839797209;14057.15657060577;16212.594685132863;13906;14376.71246575068;14449.711005779878;15027.924860375682;15161;4914.385701787277;5029.446760856303;5062.721550314731;5228.163493840986;5251.7111558864435;5302.734863256841;6053.152558641772;6338.778142765004;6340.873182536347;6365.58623689461;6083.513318934497;6306.180196574462;6327.4938004959495;6339.587926784744;6340.175777148964;5884.764609415597;6141.355157708421;6144.600600960924;6514.3811337922825;6534.08522806805;5644.774209031634;5813.709314534256;5846.795362162304;5868.76524939002;5894.764209431618;17849.375271865552;17975.191116399794;18566.814331856644;19458;19537;1990.2238127130431;2027.8783273003519;2034.206659402834;2045.7545094588745;2091.205341970057;12849.67875803103;13134.408951597106;13341.86658133416;13490.52783152585;13495.59513214605;1780.1188411736143;1813.2384398552508;1818.1727314072198;1832.2670931627322;1849.1678744564865;58209.70895145497;58566;60624;60826.695866520386;60960;14078.225697586526;14677.339519721638;14700.117992920459;14752;14792.852071479147;21717.239896603543;21834.454138646663;21888.562228755654;22052.11791528353;22158.667619985714;8550.957245213858;8629.525376104375;8629.69796057135;8717.47695138281;8739.344549158839;7264.782056538313;7265.745698900619;7277.417806575567;7298.56208627484;7337.88993165103;6345.777897773556;6668.499862510234;6936.375726184668;7186.269217697241;7229.09636295463;2812;2952.616159899242;2959.289770455075;2988.581598576201;2994.116735563014;804.1275216390283;859.4680428741639;890.2566357091771;920.9171174594319;933.7665583604099;14521.709565808836;14704.191269480281;15080;15149.394024238907;15183;834.170000849159;880.194621920948;886.3662481325883;926.4765407544716;942.7171848445439;7998.84002319962;8096.230858068474;8120.228578285171;8211.507309561446;8247.804068410167;281212;287801;289522;290611;294255;62673.37326626766;63607;64067.679661601396;65607;67809.66095169492;1034.3586976074882;1086.5056399338441;1086.6414083352633;1087.8966498182817;1109.112709832131;13119.344032798514;13405.329733513481;13422.798658020332;13523.661908452368;13675.79486307726;26596.60105098464;27103.45793084167;27344.589831152945;28035.71964280331;28468.715312846605;35369.64630353663;36687.34906929141;36987.260254794215;37286.25427491489;38536.6146338533;6197;6362.331955144643;6402.519811014099;6513.967430163008;6630;9342.579583918876;9493.525323733647;9819.690171844475;9946.45294508809;10164.237682174014;8307.6676932922;9101.544922753703;9109.18017378439;9204.263658907137;9283.071692830663;8831;9025.774355641162;9211.447313161232;9422.623095076395;9449.669261575811;9044.728658140266;9070.18368346852;9285.35002549815;9344.486053267136;9348.25213982866;6670.132882725215;6738.292479289604;6800.081988931431;6830.419414349836;6879.828004299932;8002.279794818494;8839.955800221214;8998.14517620825;9069.002409735056;9127.634894604142 06:58:11 INFO - PROCESS | 23672 | |3;mootools.html;1369.0348304445363;1382.7649299619068;1464.3264098514683;1678.8153303136646;1682.6887025900203;5982.982892908205;6097.634141951486;6839.62382068986;7001.824954376137;7051.612161331132;6543.803685889431;6696.966515167417;6720.932790672092;6745.66271686415;6754.628495432749;2080.4694802825334;2090.216168936649;2106.0417510032976;2108.283183717536;2109.9977510682456;2076.7507899052134;2082.2191678120703;2090.153487837428;2090.4982804127053;2111.2610586294827;2095.779943105967;2102.8317734581196;2107.936761897138;2107.9789202108013;2125.6811478278228;2071.1301253473503;2076.4497408186844;2077.615641106385;2080.4590806390297;2084.937451876446;2068.338131797825;2087.0608226298227;2095.057224249094;2100.159936025602;2107.525806693497;6980.371766540985;6991.300869912968;7049.859002819966;7055.294470552955;7069.257727938544;3968.047668559525;4052.4124002019544;4054.432379466877;4057.2899742545233;4071.2468193384025;2656.189862092061;2704.094128466966;2705.3101459127993;2719.170652950849;2762.323230808465;792.1444839573247;802.3340627279345;817.0767033252446;822.2312138150849;859.5487369131193;9499.28755343352;9502.382345147613;9517.524123793783;9526.666566670134;9540.856887146698;3847.480590120298;3859.710521710883;3910.569837317893;3917.2557214129224;3923.2545816294814;8256.8348633027;8264.793380165544;8265.8346833063;8268.214519620748;8268.751937441886;4157.771322577288;4162.500499940026;4174.7077704561;4175.812088456027;4177.394277829759;3306.0908250230896;3366.73066154707;3627.691646210049;3745.831437585315;3771.9434208486896;3344.063662174595;3361.109306033903;3377.5778027746533;3395.7962522248745;3411.334789716031;1008.1279693065445;1019.8521214423866;1033.2405681823852;1054.6045233037612;1058.5977328615077;1156.67613068341;1164.4527072276016;1168.9824652630218;1202.2786328203008;1204.4941124727636;6385.553011289165;6395.744170233139;6427.871442571122;6471.255805582418;6475.352464753487;402.66578739646025;404.312668463613;405.3392969459821;405.438467722201;413.1015042283082;4991.675541089818;5030.496950304941;5104.770285337168;5182.4299327073995;5194.68831870089;8224.671013159406;8502.872456913152;8513.95743021281;8571.357148213909;8604.397692161489;8165.5100693957365;8360.414770966096;8381.49711017341;8384.832303353898;8505.659773608986;6706.26231114577;6762.83092922671;6832.590044597439;6838.760643377458;6843.3840954314355;6101;6104.847378815565;6163.753449861955;6173.135760993554;6175.938240617536;7141.857162856818;7671.156172821097;7698.114716807415;7737.187595302412;7759.107702614272;7284.38082762971;7375.668094935848;7414.777556673308;7508.061492313461;7514.436417268617;5403.7838486460105;5544;6259.6870156492905;6305.243370795534;6317.810465686037;6535;6547.672616369257;6586.8353291168105;6607.471402287902;6645.335466453316;6094.451499365078;6274.686265686606;6308.179936608211;6364.522660800551;6494.64279464634;6178.814635560941;6245.437910588069;6263.498920086291;6341.492680585634;6377.521685873486;6249.875002500015;6335.873282534416;6336.619802811846;6339.904901426575;6361.650109244036;5862.794802181903;5882.23530940975;5883;5897.203877476486;5900.70496475166;5723.370429252695;5812.128180772918;5973.044312909914;5989.760409583568;6045.183900173421 06:58:11 INFO - PROCESS | 23672 | |4;prototype.html;299.9400119976005;310.22443890274315;312.1493929043356;313.15916763490014;314.7371944426404;5557.27755391799;5579.804706835262;5624.325080990277;5631;5663.2637757091525;5577;5587.106063029916;5593.161025846125;5595.21666966625;5601.439856014396;4145.896352591194;4257.084726783741;4316.740995540262;4321.827126914935;4326.026644005089;4260.126674031816;4263.509696384909;4287.678424118188;4301.612854843063;4307.289297265947;4236.51280102789;4238.3430568261965;4243.575642435747;4249.553796851333;4250.107477429743;4254.191703576326;4254.787260636956;4255.5744425557505;4259.8083086261195;4276.615104640598;3696.3900956342172;3698.278835627054;3704.2961837250837;3706.29580379727;3710.443433484972;5224.555912747421;5416.268803711528;5421.728913554307;5428.37573679028;5442.836714898559;4890.388701412324;4896.583790377822;4896.583790377822;4915.090708218955;4924.2367433047575;5938.4856861500475;5947.91078133824;5956.702164891738;5969.791057312973;5972.641641501524;4005.178938317667;4024.637782599551;4038;4042.575529569382;4046.3930410438375;6072.301685306202;6284.560080794392;6285.842853928642;6295.055741638745;6299.055141728777;4107.712460127822;4143.274926887782;4143.523494798076;4145.523264824524;4153.335466325373;4162.937555936664;4181.770002649883;4189.162167566499;4210.073783767628;4217.304144816071;4874.610031197496;4878.756062196876;4887.804487820518;4889.559939605452;4897.191963326011;5690.174924635988;5923.407659234128;5973.701314934236;5979.611325263844;5984.371640977722;1478.8151481064867;1499.1904371639412;1502.3765137468047;1503.1657430126386;1503.9323230454656;971.844504879216;981.6417007792104;983.179045497018;987.6197663899451;990.762217067913;5142.434332223527;5146.202338637517;5158.993996170786;5159.664621799571;5168.741562921914;6119.082137679295;6189.597676151036;6292.276388215414;6296.150019747367;6304.968475157595;5164.664296820694;5175.042617115771;5188.584913206934;5215.530602245816;5219.947800522022;3333.283344080986;3365.242820365447;3376.139084533428;3381.3406385754542;3381.9492707609406;5739.339975902742;5820.650760954356;5876.6180198286975;5880.8235752927485;5885.793997210077;6400.679966001681;6416.967915160394;6438.6136831790245;6448.1295025171;6452.322506136882;5879.323877754027;5885.529157667376;5892;5893.292804863444;5953.613015154001;6046.939530604637;6255.968720156552;6263.530235232467;6271.122042913905;6274.905876411766;6084.39156084388;6086.72609732572;6088.269407671108;6092.878142437038;6093.36019717941;5874.17761513397;5883.382244864399;5889.411058894077;5890.440408161217;5890.939630866314;4078.8164532596697;4079.714419990691;4094.426780250708;4098.672106231435;4105.994031462192;6029.909551356821;6201.0388389799655;6222.408871157233;6235.594686345373;6262.780802671885;5924.881502369843;5934.347221805511;5937.821865344046;5943;5949.881002380015;5908.675022873783;5917.319508256605;5945.286565611981;5950.732217050329;5955.583109182489;5667.244107853458;5744.626599271034;5757.366689664217;5770.826875193751;5777.364489906023;5993.0710739835395;5993.160957466045;6001.699915004145;6017.548683848641;6051.878962420815;5709.68596727184;5874.383189765013;5880.470757631833;5894;5896.528277737856 06:58:11 INFO - PROCESS | 23672 | |5;yui.html;721.1058287723225;725.0863911471545;727.2182403915792;758.8065043413928;803.5299349880322;10665.84001239981;10818.837717434235;10908.454577271124;10908.61819836306;10973.341599504025;10290.073893349598;11757.35334556599;11958.282503049822;12034.81947770784;12050.397480126003;761.8095476130953;764.182324912344;773.6286582440432;774.1871035412794;782.7064850680995;775.8331958628894;778.9143194248657;779.664744160011;780.7540624703229;783.913769485359;677.5223467455456;679.0289885463785;685.8902575587907;685.9691313890862;686.5297271369128;674.3896773420063;675.3617831149566;675.6790524500872;676.1615596660155;677.2685499660355;501.4959965234952;503.8589195025399;503.91937290033786;504.29398841621656;504.7425812835444;11504.137189710722;11546.480408381643;11548.595799147073;11553.826692599618;11597.6520704379;11512.94243528777;11532.25040372373;11666.300021998708;11896.702582435422;12128.757424851454;9285.58214880332;9370.578323975438;9403.29475289356;9422.152006319464;9465.716028519155;3039.7264246217724;3200.9839950800097;3256.576645036154;3265.8367081645824;3346.0798280472823;42299.78850105761;42795;43122.35316470255;43122.78438607818;43124.56875431237;9013.150382994294;9291.628334866666;9292.16370526656;9293.860592091123;9297.488638124969;16059.518214453585;16105.436309729103;16134.596635084217;16157.353705851869;16164.353425862833;6475.514336424787;6512.055751915946;6533.803985880431;6685.331466853373;6690.029945657852;3652.2695460907926;3662.597114317423;3684.5394325709285;3756.549214094326;3775.9244815103543;2565.4356041670803;2593.170185540647;2595.480903819206;2600.596907479306;2606.556885329461;433.7982837980354;438.8551777913281;440.5044325134224;448.0143683895443;453.6166938936593;458.58268975233045;459.77700815104646;477.56541547191887;508.4407152132625;541.1990254423475;7136.393406560397;7646.158922518519;7713.421493387906;7778.49439786412;7854.803629909298;488.8728930478101;540.2922171954751;552.2544564837438;563.0372063770916;609.819893879383;3502.299540091941;3534.204803919149;3535.575730912307;3558.928821423609;3727.5340582427198;45958.77020614876;46550;46894.76552617215;46901.76549117233;46996.530034699215;41543;42130.578694213276;42161.15677686429;42531.78734106372;43546.34680479732;36832;38485.615143848205;38505;38605.806970965525;38858.2228355437;6951.652417379212;6983.231844497;7103.609301488468;7151.2848715128075;7268.38218751412;29015.709842901302;29060.7093929058;29303.560446592892;29571.26071848221;29577;34285.74285442879;34328;34351.08015818583;37955.810220949825;38390.808045959595;8670.349723770616;8699.753733714579;8959.955200223958;8994.730158095268;9012.594433250388;9910.157636600681;10045.69862904114;10055.346402483816;10146.797064058825;10618.734531636463;9176.908230917872;9386.765330866783;9492.762680933032;9668;9736.075072868067;9386.526985015314;9515.619375224913;9574.66488672921;9614.855777163208;9820.754481138028;9352.438853668802;9460.905390946278;9557.044295570387;9629.085236902763;9895.960924102865;7699.153093159636;7705.113911900204;7760.417968652261;7840.059192896889;7909;7937.642806073625;8064.475809072392;8100.797480063045;8111.594420279081;8136.918630813616 06:58:11 INFO - PROCESS | 23672 | __end_tp_report 06:58:11 INFO - PROCESS | 23672 | __start_cc_report 06:58:11 INFO - PROCESS | 23672 | _x_x_mozilla_cycle_collect,320 06:58:11 INFO - PROCESS | 23672 | __end_cc_report 06:58:11 INFO - PROCESS | 23672 | __startTimestamp1453129091204__endTimestamp 06:58:11 INFO - PROCESS | 23672 | 06:58:11 INFO - PROCESS | 23672 | ------- Summary: start ------- 06:58:11 INFO - PROCESS | 23672 | Number of tests: 6 06:58:11 INFO - PROCESS | 23672 | 06:58:11 INFO - PROCESS | 23672 | [#0] dojo.html Cycles:165 Average:4471.32 Median:4605.15 stddev:442.75 (9.6%) stddev-sans-first:418.84 06:58:11 INFO - PROCESS | 23672 | Values: 2591.9 2598.1 2632.4 2642.9 2661.2 4340.4 4484.7 4486.5 4504.1 4534.8 4445.9 4506.7 4528.0 4562.8 4624.6 3993.3 4169.8 4244.6 4258.3 4304.7 4160.0 4184.6 4227.6 4252.9 4268.7 4038.9 4140.4 4141.1 4179.6 4259.5 4155.3 4162.7 4182.3 4191.5 4194.8 4031.5 4140.4 4169.6 4177.9 4182.0 4347.3 4462.5 4502.4 4511.6 4554.9 4816.0 4825.0 4862.5 4862.6 4905.4 4723.9 4783.0 4886.5 4898.8 4923.6 4459.5 4539.1 4540.2 4545.9 4569.9 4847.8 4864.6 4875.7 4905.7 4926.3 4621.5 4698.1 4710.8 4718.1 4756.2 4793.0 4806.6 4809.7 4817.2 4874.5 4681.9 4746.5 4755.7 4760.4 4775.2 4633.5 4732.6 4738.2 4740.1 4815.0 4091.4 4114.1 4115.0 4139.5 4147.9 3638.1 3642.9 3645.9 3647.5 3683.3 4091.8 4173.0 4187.5 4191.4 4240.5 4805.3 4819.5 4856.6 4865.2 4902.1 4226.2 4233.5 4236.6 4239.5 4283.0 4282.5 4356.3 4357.8 4366.6 4402.8 4536.6 4539.4 4583.4 4647.8 4652.5 4841.9 4854.1 4856.2 4894.9 4931.7 4578.4 4593.0 4623.5 4632.5 4658.1 4649.9 4731.2 4735.1 4780.1 4785.7 4830.0 4830.4 4838.2 4849.2 4878.8 4588.2 4649.1 4654.7 4662.8 4699.3 4623.7 4686.7 4732.3 4746.1 4751.1 4577.7 4587.2 4605.1 4629.1 4668.0 4622.4 4733.1 4804.8 4808.4 4821.7 4635.0 4645.4 4652.8 4655.4 4729.6 06:58:11 INFO - PROCESS | 23672 | 06:58:11 INFO - PROCESS | 23672 | [#1] ext.html Cycles:180 Average:35589.92 Median:32488.68 stddev:51939.53 (159.9%) stddev-sans-first:52018.46 06:58:11 INFO - PROCESS | 23672 | Values: 514.7 527.9 543.6 543.7 550.7 32922.3 33008.8 33165.0 33322.7 33392.3 35756.6 36277.6 36313.3 36355.0 36371.3 7664.5 7836.3 7877.6 7880.0 7889.8 7779.3 8014.6 8031.3 8035.4 8040.0 7969.5 8007.8 8056.3 8063.9 8074.6 7935.4 7976.7 8007.6 8029.0 8065.2 7788.7 7930.8 7933.3 7963.8 7983.6 36219.6 36290.5 36502.3 36532.5 36603.1 2892.2 2933.5 2958.8 2959.2 2971.5 28409.0 28583.9 28748.7 29015.9 29019.4 3402.0 3453.0 3499.8 3549.6 3591.4 157716.0 159327.2 159438.2 159462.0 159984.0 46396.5 47168.5 54375.5 54563.7 54707.0 56967.7 57753.4 58203.4 58230.7 58234.4 14191.2 14281.3 14334.6 14506.6 14509.4 10929.7 11008.1 11031.9 11052.0 11131.7 18619.7 18741.7 19135.3 19154.6 19174.7 6893.8 7187.8 7191.1 7201.4 7301.4 899.2 915.9 937.8 942.1 983.7 25372.0 26191.8 26229.6 26451.2 26596.5 942.4 966.6 977.5 1051.3 1059.4 13157.9 13318.8 13803.8 14535.6 14769.4 257893.0 260598.0 262338.0 262943.0 262949.0 45474.0 45925.3 45929.5 45958.5 45963.3 1184.5 1197.3 1219.9 1229.6 1246.4 25115.9 26472.9 26685.2 27045.5 27283.7 36156.6 36531.2 36555.0 36578.0 36605.8 158319.2 160131.0 160614.0 161423.0 161441.0 25309.5 28154.6 28470.1 28661.0 28744.3 32796.3 33185.7 33434.2 33573.8 33574.8 28342.1 28933.0 29003.0 29023.7 29459.7 30514.4 31420.4 31761.7 32474.4 32503.0 31507.8 31721.5 31839.7 32028.5 32103.4 27526.2 28585.0 29360.7 29381.1 29450.9 22928.0 23544.8 23566.5 23770.6 23778.0 06:58:11 INFO - PROCESS | 23672 | 06:58:11 INFO - PROCESS | 23672 | [#2] jquery.html Cycles:180 Average:20345.02 Median:32206.40 stddev:47662.52 (148.0%) stddev-sans-first:47772.56 06:58:11 INFO - PROCESS | 23672 | Values: 340.1 340.6 343.9 345.5 348.6 11767.5 12245.9 13813.4 14057.2 16212.6 13906.0 14376.7 14449.7 15027.9 15161.0 4914.4 5029.4 5062.7 5228.2 5251.7 5302.7 6053.2 6338.8 6340.9 6365.6 6083.5 6306.2 6327.5 6339.6 6340.2 5884.8 6141.4 6144.6 6514.4 6534.1 5644.8 5813.7 5846.8 5868.8 5894.8 17849.4 17975.2 18566.8 19458.0 19537.0 1990.2 2027.9 2034.2 2045.8 2091.2 12849.7 13134.4 13341.9 13490.5 13495.6 1780.1 1813.2 1818.2 1832.3 1849.2 58209.7 58566.0 60624.0 60826.7 60960.0 14078.2 14677.3 14700.1 14752.0 14792.9 21717.2 21834.5 21888.6 22052.1 22158.7 8551.0 8629.5 8629.7 8717.5 8739.3 7264.8 7265.7 7277.4 7298.6 7337.9 6345.8 6668.5 6936.4 7186.3 7229.1 2812.0 2952.6 2959.3 2988.6 2994.1 804.1 859.5 890.3 920.9 933.8 14521.7 14704.2 15080.0 15149.4 15183.0 834.2 880.2 886.4 926.5 942.7 7998.8 8096.2 8120.2 8211.5 8247.8 281212.0 287801.0 289522.0 290611.0 294255.0 62673.4 63607.0 64067.7 65607.0 67809.7 1034.4 1086.5 1086.6 1087.9 1109.1 13119.3 13405.3 13422.8 13523.7 13675.8 26596.6 27103.5 27344.6 28035.7 28468.7 35369.6 36687.3 36987.3 37286.3 38536.6 6197.0 6362.3 6402.5 6514.0 6630.0 9342.6 9493.5 9819.7 9946.5 10164.2 8307.7 9101.5 9109.2 9204.3 9283.1 8831.0 9025.8 9211.4 9422.6 9449.7 9044.7 9070.2 9285.4 9344.5 9348.3 6670.1 6738.3 6800.1 6830.4 6879.8 8002.3 8840.0 8998.1 9069.0 9127.6 06:58:11 INFO - PROCESS | 23672 | 06:58:11 INFO - PROCESS | 23672 | [#3] mootools.html Cycles:180 Average:4857.43 Median:5986.37 stddev:2530.89 (42.3%) stddev-sans-first:2524.41 06:58:11 INFO - PROCESS | 23672 | Values: 1369.0 1382.8 1464.3 1678.8 1682.7 5983.0 6097.6 6839.6 7001.8 7051.6 6543.8 6697.0 6720.9 6745.7 6754.6 2080.5 2090.2 2106.0 2108.3 2110.0 2076.8 2082.2 2090.2 2090.5 2111.3 2095.8 2102.8 2107.9 2108.0 2125.7 2071.1 2076.4 2077.6 2080.5 2084.9 2068.3 2087.1 2095.1 2100.2 2107.5 6980.4 6991.3 7049.9 7055.3 7069.3 3968.0 4052.4 4054.4 4057.3 4071.2 2656.2 2704.1 2705.3 2719.2 2762.3 792.1 802.3 817.1 822.2 859.5 9499.3 9502.4 9517.5 9526.7 9540.9 3847.5 3859.7 3910.6 3917.3 3923.3 8256.8 8264.8 8265.8 8268.2 8268.8 4157.8 4162.5 4174.7 4175.8 4177.4 3306.1 3366.7 3627.7 3745.8 3771.9 3344.1 3361.1 3377.6 3395.8 3411.3 1008.1 1019.9 1033.2 1054.6 1058.6 1156.7 1164.5 1169.0 1202.3 1204.5 6385.6 6395.7 6427.9 6471.3 6475.4 402.7 404.3 405.3 405.4 413.1 4991.7 5030.5 5104.8 5182.4 5194.7 8224.7 8502.9 8514.0 8571.4 8604.4 8165.5 8360.4 8381.5 8384.8 8505.7 6706.3 6762.8 6832.6 6838.8 6843.4 6101.0 6104.8 6163.8 6173.1 6175.9 7141.9 7671.2 7698.1 7737.2 7759.1 7284.4 7375.7 7414.8 7508.1 7514.4 5403.8 5544.0 6259.7 6305.2 6317.8 6535.0 6547.7 6586.8 6607.5 6645.3 6094.5 6274.7 6308.2 6364.5 6494.6 6178.8 6245.4 6263.5 6341.5 6377.5 6249.9 6335.9 6336.6 6339.9 6361.7 5862.8 5882.2 5883.0 5897.2 5900.7 5723.4 5812.1 5973.0 5989.8 6045.2 06:58:11 INFO - PROCESS | 23672 | 06:58:11 INFO - PROCESS | 23672 | [#4] prototype.html Cycles:180 Average:4902.73 Median:5598.33 stddev:1476.91 (26.4%) stddev-sans-first:1440.09 06:58:11 INFO - PROCESS | 23672 | Values: 299.9 310.2 312.1 313.2 314.7 5557.3 5579.8 5624.3 5631.0 5663.3 5577.0 5587.1 5593.2 5595.2 5601.4 4145.9 4257.1 4316.7 4321.8 4326.0 4260.1 4263.5 4287.7 4301.6 4307.3 4236.5 4238.3 4243.6 4249.6 4250.1 4254.2 4254.8 4255.6 4259.8 4276.6 3696.4 3698.3 3704.3 3706.3 3710.4 5224.6 5416.3 5421.7 5428.4 5442.8 4890.4 4896.6 4896.6 4915.1 4924.2 5938.5 5947.9 5956.7 5969.8 5972.6 4005.2 4024.6 4038.0 4042.6 4046.4 6072.3 6284.6 6285.8 6295.1 6299.1 4107.7 4143.3 4143.5 4145.5 4153.3 4162.9 4181.8 4189.2 4210.1 4217.3 4874.6 4878.8 4887.8 4889.6 4897.2 5690.2 5923.4 5973.7 5979.6 5984.4 1478.8 1499.2 1502.4 1503.2 1503.9 971.8 981.6 983.2 987.6 990.8 5142.4 5146.2 5159.0 5159.7 5168.7 6119.1 6189.6 6292.3 6296.2 6305.0 5164.7 5175.0 5188.6 5215.5 5219.9 3333.3 3365.2 3376.1 3381.3 3381.9 5739.3 5820.7 5876.6 5880.8 5885.8 6400.7 6417.0 6438.6 6448.1 6452.3 5879.3 5885.5 5892.0 5893.3 5953.6 6046.9 6256.0 6263.5 6271.1 6274.9 6084.4 6086.7 6088.3 6092.9 6093.4 5874.2 5883.4 5889.4 5890.4 5890.9 4078.8 4079.7 4094.4 4098.7 4106.0 6029.9 6201.0 6222.4 6235.6 6262.8 5924.9 5934.3 5937.8 5943.0 5949.9 5908.7 5917.3 5945.3 5950.7 5955.6 5667.2 5744.6 5757.4 5770.8 5777.4 5993.1 5993.2 6001.7 6017.5 6051.9 5709.7 5874.4 5880.5 5894.0 5896.5 06:58:11 INFO - PROCESS | 23672 | 06:58:11 INFO - PROCESS | 23672 | [#5] yui.html Cycles:180 Average:11651.26 Median:504.11 stddev:13242.79 (2627.0%) stddev-sans-first:13254.50 06:58:11 INFO - PROCESS | 23672 | Values: 721.1 725.1 727.2 758.8 803.5 10665.8 10818.8 10908.5 10908.6 10973.3 10290.1 11757.4 11958.3 12034.8 12050.4 761.8 764.2 773.6 774.2 782.7 775.8 778.9 779.7 780.8 783.9 677.5 679.0 685.9 686.0 686.5 674.4 675.4 675.7 676.2 677.3 501.5 503.9 503.9 504.3 504.7 11504.1 11546.5 11548.6 11553.8 11597.7 11512.9 11532.3 11666.3 11896.7 12128.8 9285.6 9370.6 9403.3 9422.2 9465.7 3039.7 3201.0 3256.6 3265.8 3346.1 42299.8 42795.0 43122.4 43122.8 43124.6 9013.2 9291.6 9292.2 9293.9 9297.5 16059.5 16105.4 16134.6 16157.4 16164.4 6475.5 6512.1 6533.8 6685.3 6690.0 3652.3 3662.6 3684.5 3756.5 3775.9 2565.4 2593.2 2595.5 2600.6 2606.6 433.8 438.9 440.5 448.0 453.6 458.6 459.8 477.6 508.4 541.2 7136.4 7646.2 7713.4 7778.5 7854.8 488.9 540.3 552.3 563.0 609.8 3502.3 3534.2 3535.6 3558.9 3727.5 45958.8 46550.0 46894.8 46901.8 46996.5 41543.0 42130.6 42161.2 42531.8 43546.3 36832.0 38485.6 38505.0 38605.8 38858.2 6951.7 6983.2 7103.6 7151.3 7268.4 29015.7 29060.7 29303.6 29571.3 29577.0 34285.7 34328.0 34351.1 37955.8 38390.8 8670.3 8699.8 8960.0 8994.7 9012.6 9910.2 10045.7 10055.3 10146.8 10618.7 9176.9 9386.8 9492.8 9668.0 9736.1 9386.5 9515.6 9574.7 9614.9 9820.8 9352.4 9460.9 9557.0 9629.1 9896.0 7699.2 7705.1 7760.4 7840.1 7909.0 7937.6 8064.5 8100.8 8111.6 8136.9 06:58:11 INFO - PROCESS | 23672 | -------- Summary: end -------- 06:58:11 INFO - PROCESS | 23672 | 06:58:11 INFO - TEST-INFO | 23672: exit 0 06:58:11 INFO - TEST-OK | dromaeo_css | took 1113496ms 06:58:11 INFO - TEST-START | kraken 06:58:11 INFO - operating with platform_type : linux_ 06:58:11 INFO - Initialising browser for kraken test... 06:58:11 INFO - TEST-INFO | started process 23911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmCbq1U/profile http://localhost:45786/getInfo.html) 06:58:15 INFO - PROCESS | 23911 | 06:58:15 INFO - PROCESS | 23911 | (process:23982): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:58:16 INFO - PROCESS | 23911 | __metrics Screen width/height:1600/1200 06:58:16 INFO - PROCESS | 23911 | colorDepth:24 06:58:16 INFO - PROCESS | 23911 | Browser inner width/height: 1024/697 06:58:16 INFO - PROCESS | 23911 | __metrics 06:58:16 INFO - PROCESS | 23911 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:58:17 INFO - TEST-INFO | 23911: exit 0 06:58:17 INFO - Browser initialized. 06:58:17 INFO - Running cycle 1/1 for kraken test... 06:58:17 INFO - TEST-INFO | started process 24030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmCbq1U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:17 INFO - PROCESS | 24030 | -- checkerboarding starts below -- 06:58:17 INFO - PROCESS | 24030 | RENDERTRACE 0.035991 rect red 0 0 10 10 // viewport 06:58:17 INFO - PROCESS | 24030 | RENDERTRACE 2.51024 rect red 0 0 10 10 // viewport 06:58:17 INFO - PROCESS | 24030 | RENDERTRACE 15.9764 rect red 0 0 10 10 // viewport 06:58:17 INFO - PROCESS | 24030 | RENDERTRACE 91.5536 rect brown 0 0 10 10 // page 06:58:17 INFO - PROCESS | 24030 | RENDERTRACE 91.579 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 06:58:17 INFO - PROCESS | 24030 | Checkerboarded for 3 frames (99.722 ms), 100 peak, 1596 severity. 06:58:18 INFO - PROCESS | 24030 | 06:58:18 INFO - PROCESS | 24030 | (process:24087): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:58:29 INFO - PROCESS | 24030 | RSS: Main: 149954560 06:58:29 INFO - PROCESS | 24030 | 06:58:31 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45786/tests/kraken/driver.html?testName=audio-beat-detection) 06:58:32 INFO - PROCESS | 24030 | RSS: Main: 150097920 06:58:32 INFO - PROCESS | 24030 | 06:58:35 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45786/tests/kraken/driver.html?testName=audio-dft) 06:58:35 INFO - PROCESS | 24030 | RSS: Main: 153346048 06:58:35 INFO - PROCESS | 24030 | 06:58:38 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45786/tests/kraken/driver.html?testName=audio-fft) 06:58:39 INFO - PROCESS | 24030 | RSS: Main: 148893696 06:58:39 INFO - PROCESS | 24030 | 06:58:41 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45786/tests/kraken/driver.html?testName=audio-oscillator) 06:58:41 INFO - PROCESS | 24030 | RSS: Main: 148598784 06:58:41 INFO - PROCESS | 24030 | 06:58:44 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:58:44 INFO - PROCESS | 24030 | RSS: Main: 149250048 06:58:44 INFO - PROCESS | 24030 | 06:58:47 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45786/tests/kraken/driver.html?testName=imaging-darkroom) 06:58:48 INFO - PROCESS | 24030 | RSS: Main: 149594112 06:58:48 INFO - PROCESS | 24030 | 06:58:51 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45786/tests/kraken/driver.html?testName=imaging-desaturate) 06:58:52 INFO - PROCESS | 24030 | RSS: Main: 147349504 06:58:52 INFO - PROCESS | 24030 | 06:58:55 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45786/tests/kraken/driver.html?testName=json-parse-financial) 06:58:55 INFO - PROCESS | 24030 | RSS: Main: 148160512 06:58:55 INFO - PROCESS | 24030 | 06:58:57 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:58:58 INFO - PROCESS | 24030 | RSS: Main: 148295680 06:58:58 INFO - PROCESS | 24030 | 06:59:00 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:59:00 INFO - PROCESS | 24030 | RSS: Main: 147902464 06:59:00 INFO - PROCESS | 24030 | 06:59:03 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:59:03 INFO - PROCESS | 24030 | RSS: Main: 148025344 06:59:03 INFO - PROCESS | 24030 | 06:59:06 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:59:06 INFO - PROCESS | 24030 | RSS: Main: 148447232 06:59:06 INFO - PROCESS | 24030 | 06:59:09 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:59:10 INFO - PROCESS | 24030 | RSS: Main: 147611648 06:59:10 INFO - PROCESS | 24030 | 06:59:11 INFO - PROCESS | 24030 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45786/tests/kraken/driver.html?testName=ai-astar) 06:59:12 INFO - PROCESS | 24030 | RSS: Main: 148938752 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | __start_tp_report 06:59:12 INFO - PROCESS | 24030 | _x_x_mozilla_page_load 06:59:12 INFO - PROCESS | 24030 | _x_x_mozilla_page_load_details 06:59:12 INFO - PROCESS | 24030 | |i|pagename|runs| 06:59:12 INFO - PROCESS | 24030 | |0;ai-astar;114;110;114;113;114;125;117;114;115;115 06:59:12 INFO - PROCESS | 24030 | |1;audio-beat-detection;152;143;164;177;129;154;159;135;169;135 06:59:12 INFO - PROCESS | 24030 | |2;audio-dft;164;163;165;165;165;166;171;164;161;163 06:59:12 INFO - PROCESS | 24030 | |3;audio-fft;75;73;72;140;83;74;74;72;150;76 06:59:12 INFO - PROCESS | 24030 | |4;audio-oscillator;97;98;142;98;99;97;131;97;97;129 06:59:12 INFO - PROCESS | 24030 | |5;imaging-gaussian-blur;110;110;110;109;110;110;111;110;110;109 06:59:12 INFO - PROCESS | 24030 | |6;imaging-darkroom;149;150;148;149;147;149;147;148;148;148 06:59:12 INFO - PROCESS | 24030 | |7;imaging-desaturate;96;97;97;96;96;96;96;96;96;96 06:59:12 INFO - PROCESS | 24030 | |8;json-parse-financial;72;71;71;70;71;74;71;71;72;76 06:59:12 INFO - PROCESS | 24030 | |9;json-stringify-tinderbox;67;67;67;78;67;68;71;67;69;68 06:59:12 INFO - PROCESS | 24030 | |10;stanford-crypto-aes;81;92;83;88;84;83;83;87;102;111 06:59:12 INFO - PROCESS | 24030 | |11;stanford-crypto-ccm;127;130;126;129;132;124;123;121;124;148 06:59:12 INFO - PROCESS | 24030 | |12;stanford-crypto-pbkdf2;149;150;149;149;151;152;141;147;149;141 06:59:12 INFO - PROCESS | 24030 | |13;stanford-crypto-sha256-iterative;70;72;71;72;79;76;72;71;70;70 06:59:12 INFO - PROCESS | 24030 | __end_tp_report 06:59:12 INFO - PROCESS | 24030 | __start_cc_report 06:59:12 INFO - PROCESS | 24030 | _x_x_mozilla_cycle_collect,832 06:59:12 INFO - PROCESS | 24030 | __end_cc_report 06:59:12 INFO - PROCESS | 24030 | __startTimestamp1453129152155__endTimestamp 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | ------- Summary: start ------- 06:59:12 INFO - PROCESS | 24030 | Number of tests: 14 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#0] ai-astar Cycles:10 Average:115.10 Median:114.50 stddev:3.90 (3.4%) stddev-sans-first:4.12 06:59:12 INFO - PROCESS | 24030 | Values: 114.0 110.0 114.0 113.0 114.0 125.0 117.0 114.0 115.0 115.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:156.50 stddev:15.98 (10.2%) stddev-sans-first:16.95 06:59:12 INFO - PROCESS | 24030 | Values: 152.0 143.0 164.0 177.0 129.0 154.0 159.0 135.0 169.0 135.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:2.63 (1.6%) stddev-sans-first:2.77 06:59:12 INFO - PROCESS | 24030 | Values: 164.0 163.0 165.0 165.0 165.0 166.0 171.0 164.0 161.0 163.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#3] audio-fft Cycles:10 Average:88.90 Median:74.00 stddev:29.83 (40.3%) stddev-sans-first:31.21 06:59:12 INFO - PROCESS | 24030 | Values: 75.0 73.0 72.0 140.0 83.0 74.0 74.0 72.0 150.0 76.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:97.00 stddev:17.91 (18.5%) stddev-sans-first:18.51 06:59:12 INFO - PROCESS | 24030 | Values: 97.0 98.0 142.0 98.0 99.0 97.0 131.0 97.0 97.0 129.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:59:12 INFO - PROCESS | 24030 | Values: 110.0 110.0 110.0 109.0 110.0 110.0 111.0 110.0 110.0 109.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 06:59:12 INFO - PROCESS | 24030 | Values: 149.0 150.0 148.0 149.0 147.0 149.0 147.0 148.0 148.0 148.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:59:12 INFO - PROCESS | 24030 | Values: 96.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#8] json-parse-financial Cycles:10 Average:71.90 Median:71.50 stddev:1.79 (2.5%) stddev-sans-first:1.90 06:59:12 INFO - PROCESS | 24030 | Values: 72.0 71.0 71.0 70.0 71.0 74.0 71.0 71.0 72.0 76.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:68.00 stddev:3.45 (5.1%) stddev-sans-first:3.59 06:59:12 INFO - PROCESS | 24030 | Values: 67.0 67.0 67.0 78.0 67.0 68.0 71.0 67.0 69.0 68.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:83.50 stddev:9.79 (11.7%) stddev-sans-first:9.90 06:59:12 INFO - PROCESS | 24030 | Values: 81.0 92.0 83.0 88.0 84.0 83.0 83.0 87.0 102.0 111.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:128.00 stddev:7.68 (6.0%) stddev-sans-first:8.13 06:59:12 INFO - PROCESS | 24030 | Values: 127.0 130.0 126.0 129.0 132.0 124.0 123.0 121.0 124.0 148.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:149.00 stddev:3.82 (2.6%) stddev-sans-first:4.03 06:59:12 INFO - PROCESS | 24030 | Values: 149.0 150.0 149.0 149.0 151.0 152.0 141.0 147.0 149.0 141.0 06:59:12 INFO - PROCESS | 24030 | 06:59:12 INFO - PROCESS | 24030 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:2.95 (4.1%) stddev-sans-first:3.00 06:59:12 INFO - PROCESS | 24030 | Values: 70.0 72.0 71.0 72.0 79.0 76.0 72.0 71.0 70.0 70.0 06:59:12 INFO - PROCESS | 24030 | -------- Summary: end -------- 06:59:12 INFO - PROCESS | 24030 | 06:59:13 INFO - TEST-INFO | 24030: exit 0 06:59:13 INFO - TEST-OK | kraken | took 61203ms 06:59:13 INFO - TEST-START | v8_7 06:59:13 INFO - operating with platform_type : linux_ 06:59:13 INFO - Initialising browser for v8_7 test... 06:59:13 INFO - TEST-INFO | started process 24315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWjFUCn/profile http://localhost:45786/getInfo.html) 06:59:16 INFO - PROCESS | 24315 | 06:59:16 INFO - PROCESS | 24315 | (process:24386): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:59:17 INFO - PROCESS | 24315 | __metrics Screen width/height:1600/1200 06:59:17 INFO - PROCESS | 24315 | colorDepth:24 06:59:17 INFO - PROCESS | 24315 | Browser inner width/height: 1024/697 06:59:17 INFO - PROCESS | 24315 | __metrics 06:59:17 INFO - PROCESS | 24315 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:59:18 INFO - TEST-INFO | 24315: exit 0 06:59:18 INFO - Browser initialized. 06:59:18 INFO - Running cycle 1/1 for v8_7 test... 06:59:18 INFO - TEST-INFO | started process 24434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWjFUCn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:59:19 INFO - PROCESS | 24434 | -- checkerboarding starts below -- 06:59:19 INFO - PROCESS | 24434 | RENDERTRACE 0.038458 rect red 0 0 10 10 // viewport 06:59:19 INFO - PROCESS | 24434 | RENDERTRACE 87.6653 rect brown 0 0 10 10 // page 06:59:19 INFO - PROCESS | 24434 | RENDERTRACE 87.6904 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 06:59:19 INFO - PROCESS | 24434 | Checkerboarded for 1 frames (88.9623 ms), 100 peak, 1 severity. 06:59:19 INFO - PROCESS | 24434 | 06:59:19 INFO - PROCESS | 24434 | (process:24489): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:59:30 INFO - PROCESS | 24434 | RSS: Main: 151175168 06:59:30 INFO - PROCESS | 24434 | 06:59:52 INFO - PROCESS | 24434 | Cycle 1(1): loaded http://localhost:45786/tests/v8_7/run.html (next: http://localhost:45786/tests/v8_7/run.html) 06:59:53 INFO - PROCESS | 24434 | RSS: Main: 145600512 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - PROCESS | 24434 | __start_tp_report 06:59:53 INFO - PROCESS | 24434 | _x_x_mozilla_page_load 06:59:53 INFO - PROCESS | 24434 | _x_x_mozilla_page_load_details 06:59:53 INFO - PROCESS | 24434 | |i|pagename|runs| 06:59:53 INFO - PROCESS | 24434 | |0;Richards;167.19612104999163 06:59:53 INFO - PROCESS | 24434 | |1;DeltaBlue;186.53236336504384 06:59:53 INFO - PROCESS | 24434 | |2;Encrypt;279.01785714285717 06:59:53 INFO - PROCESS | 24434 | |3;Decrypt;5319.148936170212 06:59:53 INFO - PROCESS | 24434 | |4;RayTrace;1066.0980810234541 06:59:53 INFO - PROCESS | 24434 | |5;Earley;714.7962830593281 06:59:53 INFO - PROCESS | 24434 | |6;Boyer;12407.407407407407 06:59:53 INFO - PROCESS | 24434 | |7;RegExp;43583.333333333336 06:59:53 INFO - PROCESS | 24434 | |8;Splay;597.1563981042653 06:59:53 INFO - PROCESS | 24434 | |9;NavierStokes;4835.748792270531 06:59:53 INFO - PROCESS | 24434 | __end_tp_report 06:59:53 INFO - PROCESS | 24434 | __startTimestamp1453129193032__endTimestamp 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - PROCESS | 24434 | ------- Summary: start ------- 06:59:53 INFO - PROCESS | 24434 | Number of tests: 10 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - PROCESS | 24434 | [#0] Richards Cycles:1 Average:167.20 Median:167.20 stddev:0.00 (0.0%) 06:59:53 INFO - PROCESS | 24434 | Values: 167.2 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - PROCESS | 24434 | [#1] DeltaBlue Cycles:1 Average:186.53 Median:186.53 stddev:0.00 (0.0%) 06:59:53 INFO - PROCESS | 24434 | Values: 186.5 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - PROCESS | 24434 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 06:59:53 INFO - PROCESS | 24434 | Values: 279.0 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - PROCESS | 24434 | [#3] Decrypt Cycles:1 Average:5319.15 Median:5319.15 stddev:0.00 (0.0%) 06:59:53 INFO - PROCESS | 24434 | Values: 5319.1 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - PROCESS | 24434 | [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 06:59:53 INFO - PROCESS | 24434 | Values: 1066.1 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - PROCESS | 24434 | [#5] Earley Cycles:1 Average:714.80 Median:714.80 stddev:0.00 (0.0%) 06:59:53 INFO - PROCESS | 24434 | Values: 714.8 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - PROCESS | 24434 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 06:59:53 INFO - PROCESS | 24434 | Values: 12407.4 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - PROCESS | 24434 | [#7] RegExp Cycles:1 Average:43583.33 Median:43583.33 stddev:0.00 (0.0%) 06:59:53 INFO - PROCESS | 24434 | Values: 43583.3 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - PROCESS | 24434 | [#8] Splay Cycles:1 Average:597.16 Median:597.16 stddev:0.00 (0.0%) 06:59:53 INFO - PROCESS | 24434 | Values: 597.2 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - PROCESS | 24434 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:59:53 INFO - PROCESS | 24434 | Values: 4835.7 06:59:53 INFO - PROCESS | 24434 | -------- Summary: end -------- 06:59:53 INFO - PROCESS | 24434 | 06:59:53 INFO - TEST-INFO | 24434: exit 0 06:59:53 INFO - TEST-OK | v8_7 | took 40871ms 06:59:53 INFO - SUITE-END | took 1215s 06:59:54 INFO - Completed test suite (00:20:15) 06:59:54 INFO - Working with test: dromaeo_css 06:59:54 INFO - Generating results file: dromaeo_css 06:59:54 INFO - Working with test: kraken 06:59:54 INFO - Generating results file: kraken 06:59:54 INFO - javascript benchmark 06:59:54 INFO - Working with test: v8_7 06:59:54 INFO - Generating results file: v8_7 06:59:54 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:59:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 06:59:54 INFO - process_Request line: dromaeo_css 6168.26 graph.html#tests=[[72,94,43]] 06:59:54 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:59:54 INFO - process_Request line: kraken 1562.00 graph.html#tests=[[232,94,43]] 06:59:54 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:59:54 INFO - process_Request line: v8_7 20235.85 graph.html#tests=[[230,94,43]] 06:59:54 INFO - RETURN: dromaeo_css: 6168.26 06:59:54 INFO - RETURN: kraken: 1562.00 06:59:54 INFO - RETURN: v8_7: 20235.85 06:59:54 INFO - javascript benchmark 06:59:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2591.9222423327296, 2598.0906682661057, 2632.4340266842637, 2642.854642994636, 2661.21494159223, 4340.414044104045, 4484.66365022623, 4486.484054333752, 4504.099180163968, 4534.773261336933, 4445.911081778362, 4506.707064040835, 4527.977360113195, 4562.771861406933, 4624.6300295976325, 3993.3011722948513, 4169.791510424474, 4244.575542445762, 4258.339957306623, 4304.655627549804, 4160.0, 4184.581541845821, 4227.640650544708, 4252.8511502097435, 4268.6798490113215, 4038.9192216155807, 4140.399642051885, 4141.130362623852, 4179.582041795827, 4259.51015633203, 4155.293600087993, 4162.729422587522, 4182.2890108681595, 4191.538930717618, 4194.81123349447, 4031.5162180538523, 4140.399642051885, 4169.624733773975, 4177.895552611179, 4182.038131229804, 4347.30443129101, 4462.4645042594775, 4502.4371953505815, 4511.6165125964335, 4554.931676024862, 4816.049529705895, 4824.951750482485, 4862.5380588844355, 4862.610991120702, 4905.4358748744, 4723.929141062852, 4782.976085119552, 4886.51134886512, 4898.804047838083, 4923.606111511106, 4459.531749166324, 4539.114872599811, 4540.182767101887, 4545.909081818345, 4569.862904112882, 4847.7638202258195, 4864.635152363587, 4875.658703890765, 4905.656604037683, 4926.285688575136, 4621.514740952219, 4698.083873644675, 4710.8351207707565, 4718.079974405026, 4756.167670657621, 4792.95207047932, 4806.567408933212, 4809.735464549413, 4817.1810792164715, 4874.512548745168, 4681.859544213679, 4746.5490778376, 4755.738434386073, 4760.381150450488, 4775.2359622460235, 4633.467151277646, 4732.574068333866, 4738.19450693383, 4740.14677358072, 4815.0, 4091.447654566655, 4114.115465175002, 4114.979425102855, 4139.482564679415, 4147.91704165915, 3638.0541059324237, 3642.85428582859, 3645.872394466181, 3647.452882067711, 3683.2633473305445, 4091.7954102294766, 4173.019340454991, 4187.497500299984, 4191.392248124066, 4240.469941257343, 4805.27920811881, 4819.49395313494, 4856.587190088811, 4865.172920603506, 4902.1176188285735, 4226.197022565702, 4233.534311225762, 4236.639885609758, 4239.533651298355, 4282.978585107055, 4282.507511636201, 4356.281213599784, 4357.760323182255, 4366.607005369468, 4402.757848318309, 4536.637069034469, 4539.364488971547, 4583.449986001701, 4647.837325693585, 4652.464966528893, 4841.8547443576745, 4854.053459575349, 4856.1987272099705, 4894.853154405374, 4931.72875491837, 4578.427696537933, 4592.954070459253, 4623.53764623535, 4632.467266264288, 4658.068386322817, 4649.930251046169, 4731.219348807408, 4735.100330937111, 4780.067886762048, 4785.665003449864, 4830.0, 4830.396200474941, 4838.177509823268, 4849.175640141114, 4878.80484780619, 4588.242939914877, 4649.139909116824, 4654.697444666086, 4662.813487460464, 4699.342092107039, 4623.69945953512, 4686.695364801277, 4732.313814496947, 4746.098241334135, 4751.097291514601, 4577.748223847587, 4587.151376995266, 4605.148047611203, 4629.120467111238, 4667.9766601166775, 4622.445306563234, 4733.148033354029, 4804.8318308859025, 4808.374911261513, 4821.734804585782, 4634.9536504634525, 4645.442546894395, 4652.837150699709, 4655.4413470382415, 4729.645276604199], "unit": "score", "name": "dojo.html", "value": 4445.029162254997}, {"lowerIsBetter": false, "replicates": [514.6731825290943, 527.9419263880974, 543.6058857328435, 543.6629289840298, 550.6806052489557, 32922.341553168924, 33008.834955825216, 33165.0, 33322.66677333226, 33392.33215335692, 35756.64243357565, 36277.63722362782, 36313.2737345253, 36355.0, 36371.27257454849, 7664.463487555873, 7836.2947334739865, 7877.645505952246, 7879.960600196991, 7889.8027549311155, 7779.260970207822, 8014.599270036504, 8031.277185053344, 8035.357171426301, 8040.035195776515, 7969.481983671043, 8007.839843203133, 8056.315213206855, 8063.879041814348, 8074.555899425529, 7935.365170786324, 7976.6809327626825, 8007.599620019005, 8029.036515618105, 8065.233802788696, 7788.727394541221, 7930.841383172362, 7933.286004259644, 7963.761087167394, 7983.560904150269, 36219.63780362189, 36290.45564316538, 36502.269954601026, 36532.45201321982, 36603.08492287688, 2892.24801551596, 2933.5306350983956, 2958.7632989361014, 2959.156640357488, 2971.509700899349, 28409.0, 28583.85708071467, 28748.712512874812, 29015.85492072526, 29019.41961160786, 3402.0, 3453.0, 3499.7900125992523, 3549.6450354964554, 3591.425371940477, 157716.0, 159327.2033639836, 159438.20280898636, 159462.0, 159984.0, 46396.53603463922, 47168.5283147171, 54375.45624543783, 54563.727181363836, 54707.0, 56967.71516142393, 57753.422465774805, 58203.41796582065, 58230.7088464555, 58234.4176558229, 14191.219482928538, 14281.285935703174, 14334.569962901129, 14506.564803055926, 14509.419623215164, 10929.672109836718, 11008.064314533354, 11031.889681103246, 11052.0, 11131.72170695739, 18619.720704189447, 18741.7188742169, 19135.330263440992, 19154.616907662046, 19174.712379314322, 6893.75871844483, 7187.7843664690145, 7191.101112360955, 7201.387882030086, 7301.37938275242, 899.1772528136681, 915.9221466175317, 937.7936853892132, 942.0955882353018, 983.7098056073476, 25372.0, 26191.821368038483, 26229.606555901675, 26451.206463806117, 26596.468070638864, 942.3827393057559, 966.5650457294246, 977.4819345746765, 1051.3271506236015, 1059.4014381874217, 13157.934210329078, 13318.800217996737, 13803.792943105862, 14535.636609084857, 14769.40922363115, 257893.0, 260598.0, 262338.0, 262943.0, 262949.0, 45474.0, 45925.31112033322, 45929.540704592524, 45958.54041459609, 45963.31055034177, 1184.5084290019545, 1197.2696655040418, 1219.945102470391, 1229.569650622275, 1246.3643541793751, 25115.87442062778, 26472.8676356617, 26685.19944401671, 27045.45909081768, 27283.72716272812, 36156.63843361638, 36531.173441328356, 36555.0, 36578.0, 36605.81697091497, 158319.20840395725, 160131.0, 160614.0, 161423.0, 161441.0, 25309.493810123327, 28154.577681334387, 28470.145895623165, 28661.0, 28744.281392965342, 32796.34407311793, 33185.66814331922, 33434.164145896546, 33573.83213083919, 33574.83212583922, 28342.149735507966, 28933.0, 29003.0, 29023.7097629021, 29459.705402945696, 30514.389712205186, 31420.371592567564, 31761.682383176798, 32474.35051299008, 32503.0, 31507.842460788466, 31721.5241771369, 31839.6816031846, 32028.5195722069, 32103.357932841678, 27526.17421477359, 28584.955968322975, 29360.706392935797, 29381.11856644304, 29450.852745736134, 22928.0, 23544.764552354944, 23566.528669426174, 23770.643440348755, 23778.0], "unit": "score", "name": "ext.html", "value": 16162.894639937647}, {"lowerIsBetter": false, "replicates": [340.1462329552823, 340.61340378670207, 343.86589230200224, 345.51282691405106, 348.5695166469408, 11767.529298828058, 12245.938770306158, 13813.37839797209, 14057.15657060577, 16212.594685132863, 13906.0, 14376.71246575068, 14449.711005779878, 15027.924860375682, 15161.0, 4914.385701787277, 5029.446760856303, 5062.721550314731, 5228.163493840986, 5251.7111558864435, 5302.734863256841, 6053.152558641772, 6338.778142765004, 6340.873182536347, 6365.58623689461, 6083.513318934497, 6306.180196574462, 6327.4938004959495, 6339.587926784744, 6340.175777148964, 5884.764609415597, 6141.355157708421, 6144.600600960924, 6514.3811337922825, 6534.08522806805, 5644.774209031634, 5813.709314534256, 5846.795362162304, 5868.76524939002, 5894.764209431618, 17849.375271865552, 17975.191116399794, 18566.814331856644, 19458.0, 19537.0, 1990.2238127130431, 2027.8783273003519, 2034.206659402834, 2045.7545094588745, 2091.205341970057, 12849.67875803103, 13134.408951597106, 13341.86658133416, 13490.52783152585, 13495.59513214605, 1780.1188411736143, 1813.2384398552508, 1818.1727314072198, 1832.2670931627322, 1849.1678744564865, 58209.70895145497, 58566.0, 60624.0, 60826.695866520386, 60960.0, 14078.225697586526, 14677.339519721638, 14700.117992920459, 14752.0, 14792.852071479147, 21717.239896603543, 21834.454138646663, 21888.562228755654, 22052.11791528353, 22158.667619985714, 8550.957245213858, 8629.525376104375, 8629.69796057135, 8717.47695138281, 8739.344549158839, 7264.782056538313, 7265.745698900619, 7277.417806575567, 7298.56208627484, 7337.88993165103, 6345.777897773556, 6668.499862510234, 6936.375726184668, 7186.269217697241, 7229.09636295463, 2812.0, 2952.616159899242, 2959.289770455075, 2988.581598576201, 2994.116735563014, 804.1275216390283, 859.4680428741639, 890.2566357091771, 920.9171174594319, 933.7665583604099, 14521.709565808836, 14704.191269480281, 15080.0, 15149.394024238907, 15183.0, 834.170000849159, 880.194621920948, 886.3662481325883, 926.4765407544716, 942.7171848445439, 7998.84002319962, 8096.230858068474, 8120.228578285171, 8211.507309561446, 8247.804068410167, 281212.0, 287801.0, 289522.0, 290611.0, 294255.0, 62673.37326626766, 63607.0, 64067.679661601396, 65607.0, 67809.66095169492, 1034.3586976074882, 1086.5056399338441, 1086.6414083352633, 1087.8966498182817, 1109.112709832131, 13119.344032798514, 13405.329733513481, 13422.798658020332, 13523.661908452368, 13675.79486307726, 26596.60105098464, 27103.45793084167, 27344.589831152945, 28035.71964280331, 28468.715312846605, 35369.64630353663, 36687.34906929141, 36987.260254794215, 37286.25427491489, 38536.6146338533, 6197.0, 6362.331955144643, 6402.519811014099, 6513.967430163008, 6630.0, 9342.579583918876, 9493.525323733647, 9819.690171844475, 9946.45294508809, 10164.237682174014, 8307.6676932922, 9101.544922753703, 9109.18017378439, 9204.263658907137, 9283.071692830663, 8831.0, 9025.774355641162, 9211.447313161232, 9422.623095076395, 9449.669261575811, 9044.728658140266, 9070.18368346852, 9285.35002549815, 9344.486053267136, 9348.25213982866, 6670.132882725215, 6738.292479289604, 6800.081988931431, 6830.419414349836, 6879.828004299932, 8002.279794818494, 8839.955800221214, 8998.14517620825, 9069.002409735056, 9127.634894604142], "unit": "score", "name": "jquery.html", "value": 8208.691510422577}, {"lowerIsBetter": false, "replicates": [1369.0348304445363, 1382.7649299619068, 1464.3264098514683, 1678.8153303136646, 1682.6887025900203, 5982.982892908205, 6097.634141951486, 6839.62382068986, 7001.824954376137, 7051.612161331132, 6543.803685889431, 6696.966515167417, 6720.932790672092, 6745.66271686415, 6754.628495432749, 2080.4694802825334, 2090.216168936649, 2106.0417510032976, 2108.283183717536, 2109.9977510682456, 2076.7507899052134, 2082.2191678120703, 2090.153487837428, 2090.4982804127053, 2111.2610586294827, 2095.779943105967, 2102.8317734581196, 2107.936761897138, 2107.9789202108013, 2125.6811478278228, 2071.1301253473503, 2076.4497408186844, 2077.615641106385, 2080.4590806390297, 2084.937451876446, 2068.338131797825, 2087.0608226298227, 2095.057224249094, 2100.159936025602, 2107.525806693497, 6980.371766540985, 6991.300869912968, 7049.859002819966, 7055.294470552955, 7069.257727938544, 3968.047668559525, 4052.4124002019544, 4054.432379466877, 4057.2899742545233, 4071.2468193384025, 2656.189862092061, 2704.094128466966, 2705.3101459127993, 2719.170652950849, 2762.323230808465, 792.1444839573247, 802.3340627279345, 817.0767033252446, 822.2312138150849, 859.5487369131193, 9499.28755343352, 9502.382345147613, 9517.524123793783, 9526.666566670134, 9540.856887146698, 3847.480590120298, 3859.710521710883, 3910.569837317893, 3917.2557214129224, 3923.2545816294814, 8256.8348633027, 8264.793380165544, 8265.8346833063, 8268.214519620748, 8268.751937441886, 4157.771322577288, 4162.500499940026, 4174.7077704561, 4175.812088456027, 4177.394277829759, 3306.0908250230896, 3366.73066154707, 3627.691646210049, 3745.831437585315, 3771.9434208486896, 3344.063662174595, 3361.109306033903, 3377.5778027746533, 3395.7962522248745, 3411.334789716031, 1008.1279693065445, 1019.8521214423866, 1033.2405681823852, 1054.6045233037612, 1058.5977328615077, 1156.67613068341, 1164.4527072276016, 1168.9824652630218, 1202.2786328203008, 1204.4941124727636, 6385.553011289165, 6395.744170233139, 6427.871442571122, 6471.255805582418, 6475.352464753487, 402.66578739646025, 404.312668463613, 405.3392969459821, 405.438467722201, 413.1015042283082, 4991.675541089818, 5030.496950304941, 5104.770285337168, 5182.4299327073995, 5194.68831870089, 8224.671013159406, 8502.872456913152, 8513.95743021281, 8571.357148213909, 8604.397692161489, 8165.5100693957365, 8360.414770966096, 8381.49711017341, 8384.832303353898, 8505.659773608986, 6706.26231114577, 6762.83092922671, 6832.590044597439, 6838.760643377458, 6843.3840954314355, 6101.0, 6104.847378815565, 6163.753449861955, 6173.135760993554, 6175.938240617536, 7141.857162856818, 7671.156172821097, 7698.114716807415, 7737.187595302412, 7759.107702614272, 7284.38082762971, 7375.668094935848, 7414.777556673308, 7508.061492313461, 7514.436417268617, 5403.7838486460105, 5544.0, 6259.6870156492905, 6305.243370795534, 6317.810465686037, 6535.0, 6547.672616369257, 6586.8353291168105, 6607.471402287902, 6645.335466453316, 6094.451499365078, 6274.686265686606, 6308.179936608211, 6364.522660800551, 6494.64279464634, 6178.814635560941, 6245.437910588069, 6263.498920086291, 6341.492680585634, 6377.521685873486, 6249.875002500015, 6335.873282534416, 6336.619802811846, 6339.904901426575, 6361.650109244036, 5862.794802181903, 5882.23530940975, 5883.0, 5897.203877476486, 5900.70496475166, 5723.370429252695, 5812.128180772918, 5973.044312909914, 5989.760409583568, 6045.183900173421], "unit": "score", "name": "mootools.html", "value": 3926.840549483267}, {"lowerIsBetter": false, "replicates": [299.9400119976005, 310.22443890274315, 312.1493929043356, 313.15916763490014, 314.7371944426404, 5557.27755391799, 5579.804706835262, 5624.325080990277, 5631.0, 5663.2637757091525, 5577.0, 5587.106063029916, 5593.161025846125, 5595.21666966625, 5601.439856014396, 4145.896352591194, 4257.084726783741, 4316.740995540262, 4321.827126914935, 4326.026644005089, 4260.126674031816, 4263.509696384909, 4287.678424118188, 4301.612854843063, 4307.289297265947, 4236.51280102789, 4238.3430568261965, 4243.575642435747, 4249.553796851333, 4250.107477429743, 4254.191703576326, 4254.787260636956, 4255.5744425557505, 4259.8083086261195, 4276.615104640598, 3696.3900956342172, 3698.278835627054, 3704.2961837250837, 3706.29580379727, 3710.443433484972, 5224.555912747421, 5416.268803711528, 5421.728913554307, 5428.37573679028, 5442.836714898559, 4890.388701412324, 4896.583790377822, 4896.583790377822, 4915.090708218955, 4924.2367433047575, 5938.4856861500475, 5947.91078133824, 5956.702164891738, 5969.791057312973, 5972.641641501524, 4005.178938317667, 4024.637782599551, 4038.0, 4042.575529569382, 4046.3930410438375, 6072.301685306202, 6284.560080794392, 6285.842853928642, 6295.055741638745, 6299.055141728777, 4107.712460127822, 4143.274926887782, 4143.523494798076, 4145.523264824524, 4153.335466325373, 4162.937555936664, 4181.770002649883, 4189.162167566499, 4210.073783767628, 4217.304144816071, 4874.610031197496, 4878.756062196876, 4887.804487820518, 4889.559939605452, 4897.191963326011, 5690.174924635988, 5923.407659234128, 5973.701314934236, 5979.611325263844, 5984.371640977722, 1478.8151481064867, 1499.1904371639412, 1502.3765137468047, 1503.1657430126386, 1503.9323230454656, 971.844504879216, 981.6417007792104, 983.179045497018, 987.6197663899451, 990.762217067913, 5142.434332223527, 5146.202338637517, 5158.993996170786, 5159.664621799571, 5168.741562921914, 6119.082137679295, 6189.597676151036, 6292.276388215414, 6296.150019747367, 6304.968475157595, 5164.664296820694, 5175.042617115771, 5188.584913206934, 5215.530602245816, 5219.947800522022, 3333.283344080986, 3365.242820365447, 3376.139084533428, 3381.3406385754542, 3381.9492707609406, 5739.339975902742, 5820.650760954356, 5876.6180198286975, 5880.8235752927485, 5885.793997210077, 6400.679966001681, 6416.967915160394, 6438.6136831790245, 6448.1295025171, 6452.322506136882, 5879.323877754027, 5885.529157667376, 5892.0, 5893.292804863444, 5953.613015154001, 6046.939530604637, 6255.968720156552, 6263.530235232467, 6271.122042913905, 6274.905876411766, 6084.39156084388, 6086.72609732572, 6088.269407671108, 6092.878142437038, 6093.36019717941, 5874.17761513397, 5883.382244864399, 5889.411058894077, 5890.440408161217, 5890.939630866314, 4078.8164532596697, 4079.714419990691, 4094.426780250708, 4098.672106231435, 4105.994031462192, 6029.909551356821, 6201.0388389799655, 6222.408871157233, 6235.594686345373, 6262.780802671885, 5924.881502369843, 5934.347221805511, 5937.821865344046, 5943.0, 5949.881002380015, 5908.675022873783, 5917.319508256605, 5945.286565611981, 5950.732217050329, 5955.583109182489, 5667.244107853458, 5744.626599271034, 5757.366689664217, 5770.826875193751, 5777.364489906023, 5993.0710739835395, 5993.160957466045, 6001.699915004145, 6017.548683848641, 6051.878962420815, 5709.68596727184, 5874.383189765013, 5880.470757631833, 5894.0, 5896.528277737856], "unit": "score", "name": "prototype.html", "value": 4422.442512324038}, {"lowerIsBetter": false, "replicates": [721.1058287723225, 725.0863911471545, 727.2182403915792, 758.8065043413928, 803.5299349880322, 10665.84001239981, 10818.837717434235, 10908.454577271124, 10908.61819836306, 10973.341599504025, 10290.073893349598, 11757.35334556599, 11958.282503049822, 12034.81947770784, 12050.397480126003, 761.8095476130953, 764.182324912344, 773.6286582440432, 774.1871035412794, 782.7064850680995, 775.8331958628894, 778.9143194248657, 779.664744160011, 780.7540624703229, 783.913769485359, 677.5223467455456, 679.0289885463785, 685.8902575587907, 685.9691313890862, 686.5297271369128, 674.3896773420063, 675.3617831149566, 675.6790524500872, 676.1615596660155, 677.2685499660355, 501.4959965234952, 503.8589195025399, 503.91937290033786, 504.29398841621656, 504.7425812835444, 11504.137189710722, 11546.480408381643, 11548.595799147073, 11553.826692599618, 11597.6520704379, 11512.94243528777, 11532.25040372373, 11666.300021998708, 11896.702582435422, 12128.757424851454, 9285.58214880332, 9370.578323975438, 9403.29475289356, 9422.152006319464, 9465.716028519155, 3039.7264246217724, 3200.9839950800097, 3256.576645036154, 3265.8367081645824, 3346.0798280472823, 42299.78850105761, 42795.0, 43122.35316470255, 43122.78438607818, 43124.56875431237, 9013.150382994294, 9291.628334866666, 9292.16370526656, 9293.860592091123, 9297.488638124969, 16059.518214453585, 16105.436309729103, 16134.596635084217, 16157.353705851869, 16164.353425862833, 6475.514336424787, 6512.055751915946, 6533.803985880431, 6685.331466853373, 6690.029945657852, 3652.2695460907926, 3662.597114317423, 3684.5394325709285, 3756.549214094326, 3775.9244815103543, 2565.4356041670803, 2593.170185540647, 2595.480903819206, 2600.596907479306, 2606.556885329461, 433.7982837980354, 438.8551777913281, 440.5044325134224, 448.0143683895443, 453.6166938936593, 458.58268975233045, 459.77700815104646, 477.56541547191887, 508.4407152132625, 541.1990254423475, 7136.393406560397, 7646.158922518519, 7713.421493387906, 7778.49439786412, 7854.803629909298, 488.8728930478101, 540.2922171954751, 552.2544564837438, 563.0372063770916, 609.819893879383, 3502.299540091941, 3534.204803919149, 3535.575730912307, 3558.928821423609, 3727.5340582427198, 45958.77020614876, 46550.0, 46894.76552617215, 46901.76549117233, 46996.530034699215, 41543.0, 42130.578694213276, 42161.15677686429, 42531.78734106372, 43546.34680479732, 36832.0, 38485.615143848205, 38505.0, 38605.806970965525, 38858.2228355437, 6951.652417379212, 6983.231844497, 7103.609301488468, 7151.2848715128075, 7268.38218751412, 29015.709842901302, 29060.7093929058, 29303.560446592892, 29571.26071848221, 29577.0, 34285.74285442879, 34328.0, 34351.08015818583, 37955.810220949825, 38390.808045959595, 8670.349723770616, 8699.753733714579, 8959.955200223958, 8994.730158095268, 9012.594433250388, 9910.157636600681, 10045.69862904114, 10055.346402483816, 10146.797064058825, 10618.734531636463, 9176.908230917872, 9386.765330866783, 9492.762680933032, 9668.0, 9736.075072868067, 9386.526985015314, 9515.619375224913, 9574.66488672921, 9614.855777163208, 9820.754481138028, 9352.438853668802, 9460.905390946278, 9557.044295570387, 9629.085236902763, 9895.960924102865, 7699.153093159636, 7705.113911900204, 7760.417968652261, 7840.059192896889, 7909.0, 7937.642806073625, 8064.475809072392, 8100.797480063045, 8111.594420279081, 8136.918630813616], "unit": "score", "name": "yui.html", "value": 5377.2213496177765}], "name": "dromaeo_css", "value": 6168.259107418794}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 114.0, 113.0, 114.0, 125.0, 117.0, 114.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.1}, {"lowerIsBetter": true, "replicates": [152.0, 143.0, 164.0, 177.0, 129.0, 154.0, 159.0, 135.0, 169.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 151.7}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 165.0, 165.0, 165.0, 166.0, 171.0, 164.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 72.0, 140.0, 83.0, 74.0, 74.0, 72.0, 150.0, 76.0], "unit": "score", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 142.0, 98.0, 99.0, 97.0, 131.0, 97.0, 97.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [149.0, 150.0, 148.0, 149.0, 147.0, 149.0, 147.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 70.0, 71.0, 74.0, 71.0, 71.0, 72.0, 76.0], "unit": "score", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 78.0, 67.0, 68.0, 71.0, 67.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [81.0, 92.0, 83.0, 88.0, 84.0, 83.0, 83.0, 87.0, 102.0, 111.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.4}, {"lowerIsBetter": true, "replicates": [127.0, 130.0, 126.0, 129.0, 132.0, 124.0, 123.0, 121.0, 124.0, 148.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.4}, {"lowerIsBetter": true, "replicates": [149.0, 150.0, 149.0, 149.0, 151.0, 152.0, 141.0, 147.0, 149.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 71.0, 72.0, 79.0, 76.0, 72.0, 71.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1562.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.19612104999163], "unit": "score", "name": "Richards", "value": 211.14126199999998}, {"lowerIsBetter": false, "replicates": [186.53236336504384], "unit": "score", "name": "DeltaBlue", "value": 354.4585980000001}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5319.148936170212], "unit": "score", "name": "Decrypt", "value": 50.04202800000001}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [714.7962830593281], "unit": "score", "name": "Earley", "value": 932.381737}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [43583.333333333336], "unit": "score", "name": "RegExp", "value": 20.902141491395785}, {"lowerIsBetter": false, "replicates": [597.1563981042653], "unit": "score", "name": "Splay", "value": 136.4650873015873}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20235.84704535186}]} 06:59:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20235.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1562.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6168.26"}}} 06:59:54 INFO - Return code: 0 06:59:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:59:54 INFO - # TBPL SUCCESS # 06:59:54 INFO - Running post-action listener: _resource_record_post_action 06:59:54 INFO - Running post-run listener: _resource_record_post_run 06:59:55 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 77824; Write bytes: 406855680; Read time: 276; Write time: 209284 06:59:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 96673792; Read time: 140; Write time: 50488 06:59:55 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 73728; Write bytes: 310181888; Read time: 136; Write time: 158796 06:59:55 INFO - Running post-run listener: _upload_blobber_files 06:59:55 INFO - Blob upload gear active. 06:59:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:59:55 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 06:59:55 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'] 06:59:55 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 06:59:55 INFO - (blobuploader) - INFO - Open directory for files ... 06:59:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:59:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:59:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:56 INFO - (blobuploader) - INFO - Done attempting. 06:59:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:59:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:59:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:57 INFO - (blobuploader) - INFO - Done attempting. 06:59:57 INFO - (blobuploader) - INFO - Iteration through files over. 06:59:57 INFO - Return code: 0 06:59:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:59:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:59:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8eef73420c433c81a64a537056ed5c86e254c7b606376e6260a2c70091168dd0892514ae4ed8f400a27b254339d8cf2d539f3f7c5ece833ca65a2243854b3a10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8bcfd8c0933a5d5d69448dd98bc147b4b08f7fe408d909cef1f027d90c7038ec062cd4cf8e4aa125634a4b2550accff585427a18cc37e3767ec751f3de13786"} 06:59:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:59:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:59:57 INFO - Contents: 06:59:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8eef73420c433c81a64a537056ed5c86e254c7b606376e6260a2c70091168dd0892514ae4ed8f400a27b254339d8cf2d539f3f7c5ece833ca65a2243854b3a10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8bcfd8c0933a5d5d69448dd98bc147b4b08f7fe408d909cef1f027d90c7038ec062cd4cf8e4aa125634a4b2550accff585427a18cc37e3767ec751f3de13786"} 06:59:57 INFO - Running post-run listener: copy_logs_to_upload_dir 06:59:57 INFO - Copying logs to upload dir... 06:59:57 INFO - mkdir: /builds/slave/test/build/upload/logs 06:59:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.493801 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-18 06:59:57.550930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 06:59:57.555822) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8eef73420c433c81a64a537056ed5c86e254c7b606376e6260a2c70091168dd0892514ae4ed8f400a27b254339d8cf2d539f3f7c5ece833ca65a2243854b3a10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8bcfd8c0933a5d5d69448dd98bc147b4b08f7fe408d909cef1f027d90c7038ec062cd4cf8e4aa125634a4b2550accff585427a18cc37e3767ec751f3de13786"} build_url:https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/XWaHLEtDQy6xHkkCL7bO9g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8eef73420c433c81a64a537056ed5c86e254c7b606376e6260a2c70091168dd0892514ae4ed8f400a27b254339d8cf2d539f3f7c5ece833ca65a2243854b3a10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8bcfd8c0933a5d5d69448dd98bc147b4b08f7fe408d909cef1f027d90c7038ec062cd4cf8e4aa125634a4b2550accff585427a18cc37e3767ec751f3de13786"}' ========= master_lag: 0.40 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 06:59:57.966815) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 06:59:57.967182) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453123272.478642-1417084733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 06:59:58.017287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 06:59:58.020664) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 06:59:58.020996) ========= ========= Total master_lag: 0.68 =========