builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1447974155.29 results: success (0) buildid: 20151119141035 builduid: a91028e433744acd9ff4daca508cc381 revision: 87191bd52446546f2427d4d2d524792aa15964fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.288876) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.289318) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.289637) ========= 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=7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006596 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.309771) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.310058) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.317882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.318155) ========= 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=7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.367631) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.367936) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.368305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.368573) ========= 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=7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 15:02:35-- 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% 55.8M=0s 2015-11-19 15:02:35 (55.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186757 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.619158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.619463) ========= 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=7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015145 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:35.646015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-19 15:02:35.646364) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 87191bd52446546f2427d4d2d524792aa15964fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 87191bd52446546f2427d4d2d524792aa15964fa --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=7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 15:02:35,730 truncating revision to first 12 chars 2015-11-19 15:02:35,730 Setting DEBUG logging. 2015-11-19 15:02:35,730 attempt 1/10 2015-11-19 15:02:35,730 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/87191bd52446?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 15:02:36,707 unpacking tar archive at: mozilla-inbound-87191bd52446/testing/mozharness/ program finished with exit code 0 elapsedTime=1.278815 ========= master_lag: 0.84 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-19 15:02:37.761248) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:37.761557) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:37.771488) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:37.771758) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 15:02:37.772133) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-19 15:02:37.772409) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:02:37 INFO - MultiFileLogger online at 20151119 15:02:37 in /builds/slave/test 15:02:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 15:02:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:02:37 INFO - {'append_to_log': False, 15:02:37 INFO - 'base_work_dir': '/builds/slave/test', 15:02:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 15:02:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:02:37 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 15:02:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:02:37 INFO - 'config_files': ('talos/linux_config.py',), 15:02:37 INFO - 'default_actions': ('clobber', 15:02:37 INFO - 'read-buildbot-config', 15:02:37 INFO - 'download-and-extract', 15:02:37 INFO - 'populate-webroot', 15:02:37 INFO - 'create-virtualenv', 15:02:37 INFO - 'install', 15:02:37 INFO - 'run-tests'), 15:02:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:02:37 INFO - 'download_minidump_stackwalk': True, 15:02:37 INFO - 'download_symbols': 'ondemand', 15:02:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:02:37 INFO - 'tooltool.py': '/tools/tooltool.py', 15:02:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:02:37 INFO - '/tools/misc-python/virtualenv.py')}, 15:02:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:02:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:02:37 INFO - 'installer_path': 'installer.exe', 15:02:37 INFO - 'log_level': 'info', 15:02:37 INFO - 'log_name': 'talos', 15:02:37 INFO - 'log_to_console': True, 15:02:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:02:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:02:37 INFO - 'opt_config_files': (), 15:02:37 INFO - 'pip_index': False, 15:02:37 INFO - 'sps_profile': False, 15:02:37 INFO - 'sps_profile_interval': 0, 15:02:37 INFO - 'suite': 'dromaeojs', 15:02:37 INFO - 'system_bits': '64', 15:02:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:02:37 INFO - 'title': 'talos-linux64-ix-008', 15:02:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:02:37 INFO - 'use_talos_json': True, 15:02:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:02:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:02:37 INFO - 'work_dir': 'build'} 15:02:37 INFO - ##### 15:02:37 INFO - ##### Running clobber step. 15:02:37 INFO - ##### 15:02:37 INFO - Running pre-action listener: _resource_record_pre_action 15:02:37 INFO - Running main action method: clobber 15:02:37 INFO - rmtree: /builds/slave/test/build 15:02:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:02:38 INFO - Running post-action listener: _resource_record_post_action 15:02:38 INFO - ##### 15:02:38 INFO - ##### Running read-buildbot-config step. 15:02:38 INFO - ##### 15:02:38 INFO - Running pre-action listener: _resource_record_pre_action 15:02:38 INFO - Running main action method: read_buildbot_config 15:02:38 INFO - Using buildbot properties: 15:02:38 INFO - { 15:02:38 INFO - "properties": { 15:02:38 INFO - "buildnumber": 5957, 15:02:38 INFO - "product": "firefox", 15:02:38 INFO - "script_repo_revision": "production", 15:02:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:02:38 INFO - "repository": "", 15:02:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 15:02:38 INFO - "buildid": "20151119141035", 15:02:38 INFO - "slavename": "talos-linux64-ix-008", 15:02:38 INFO - "pgo_build": "False", 15:02:38 INFO - "basedir": "/builds/slave/test", 15:02:38 INFO - "project": "", 15:02:38 INFO - "platform": "ubuntu64_hw", 15:02:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:02:38 INFO - "slavebuilddir": "test", 15:02:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 15:02:38 INFO - "branch": "mozilla-inbound", 15:02:38 INFO - "repo_path": "integration/mozilla-inbound", 15:02:38 INFO - "stage_platform": "linux64", 15:02:38 INFO - "builduid": "a91028e433744acd9ff4daca508cc381", 15:02:38 INFO - "revision": "87191bd52446546f2427d4d2d524792aa15964fa" 15:02:38 INFO - }, 15:02:38 INFO - "sourcestamp": { 15:02:38 INFO - "repository": "", 15:02:38 INFO - "hasPatch": false, 15:02:38 INFO - "project": "", 15:02:38 INFO - "branch": "mozilla-inbound-linux64-talos", 15:02:38 INFO - "changes": [ 15:02:38 INFO - { 15:02:38 INFO - "category": null, 15:02:38 INFO - "files": [ 15:02:38 INFO - { 15:02:38 INFO - "url": null, 15:02:38 INFO - "name": "https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:02:38 INFO - } 15:02:38 INFO - ], 15:02:38 INFO - "repository": "", 15:02:38 INFO - "rev": "87191bd52446546f2427d4d2d524792aa15964fa", 15:02:38 INFO - "who": "tcole@mozilla.com", 15:02:38 INFO - "when": 1447973276, 15:02:38 INFO - "number": 6685486, 15:02:38 INFO - "comments": "No Bug - Remove two unused, orphan variables; r=sfink", 15:02:38 INFO - "project": "", 15:02:38 INFO - "at": "Thu 19 Nov 2015 14:47:56", 15:02:38 INFO - "branch": "mozilla-inbound-linux64-talos", 15:02:38 INFO - "revlink": "", 15:02:38 INFO - "properties": [ 15:02:38 INFO - [ 15:02:38 INFO - "buildid", 15:02:38 INFO - "20151119141035", 15:02:38 INFO - "Change" 15:02:38 INFO - ], 15:02:38 INFO - [ 15:02:38 INFO - "builduid", 15:02:38 INFO - "a91028e433744acd9ff4daca508cc381", 15:02:38 INFO - "Change" 15:02:38 INFO - ], 15:02:38 INFO - [ 15:02:38 INFO - "pgo_build", 15:02:38 INFO - "False", 15:02:38 INFO - "Change" 15:02:38 INFO - ] 15:02:38 INFO - ], 15:02:38 INFO - "revision": "87191bd52446546f2427d4d2d524792aa15964fa" 15:02:38 INFO - } 15:02:38 INFO - ], 15:02:38 INFO - "revision": "87191bd52446546f2427d4d2d524792aa15964fa" 15:02:38 INFO - } 15:02:38 INFO - } 15:02:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:02:38 INFO - Running post-action listener: _resource_record_post_action 15:02:38 INFO - ##### 15:02:38 INFO - ##### Running download-and-extract step. 15:02:38 INFO - ##### 15:02:38 INFO - Running pre-action listener: _resource_record_pre_action 15:02:38 INFO - Running main action method: download_and_extract 15:02:38 INFO - mkdir: /builds/slave/test/build/tests 15:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:38 INFO - https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:02:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/test_packages.json 15:02:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/test_packages.json 15:02:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:02:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:02:39 INFO - Downloaded 1302 bytes. 15:02:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:02:39 INFO - Using the following test package requirements: 15:02:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:02:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:39 INFO - u'jsshell-linux-x86_64.zip'], 15:02:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:02:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:02:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:02:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:02:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:02:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:39 INFO - https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:02:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:02:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:02:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:02:45 INFO - Downloaded 21345812 bytes. 15:02:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 15:02:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:02:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:02:46 INFO - Return code: 0 15:02:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:46 INFO - https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:02:47 INFO - Downloaded 21345812 bytes. 15:02:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 15:02:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:02:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:02:49 INFO - Return code: 0 15:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:49 INFO - https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:02:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:02:50 INFO - Downloaded 11130997 bytes. 15:02:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 15:02:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:02:50 INFO - Return code: 0 15:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:50 INFO - https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:02:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:02:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:02:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:02:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:02:51 INFO - Downloaded 55778645 bytes. 15:02:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:02:51 INFO - mkdir: /builds/slave/test/properties 15:02:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:02:51 INFO - Writing to file /builds/slave/test/properties/build_url 15:02:51 INFO - Contents: 15:02:51 INFO - build_url:https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:02:51 INFO - Running post-action listener: _resource_record_post_action 15:02:51 INFO - Running post-action listener: set_extra_try_arguments 15:02:51 INFO - ##### 15:02:51 INFO - ##### Running populate-webroot step. 15:02:51 INFO - ##### 15:02:51 INFO - Running pre-action listener: _resource_record_pre_action 15:02:51 INFO - Running main action method: populate_webroot 15:02:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:02:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:02:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:02:51 INFO - '../fennec_ids.txt'], 15:02:51 INFO - 'tests': ['tcheck2']}, 15:02:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:02:51 INFO - '--tppagecycles', 15:02:51 INFO - '7'], 15:02:51 INFO - 'tests': ['tsvgm']}}, 15:02:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:02:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:02:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:02:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:02:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:02:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:02:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:51 INFO - 'talos_options': ['--e10s'], 15:02:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:51 INFO - 'tests': ['damp', 'tps']}, 15:02:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:51 INFO - 'talos_options': ['--e10s'], 15:02:51 INFO - 'tests': ['damp', 'tps']}, 15:02:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:02:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:02:51 INFO - 'other': {'tests': ['a11yr', 15:02:51 INFO - 'ts_paint', 15:02:51 INFO - 'tpaint', 15:02:51 INFO - 'sessionrestore', 15:02:51 INFO - 'sessionrestore_no_auto_restore']}, 15:02:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:02:51 INFO - 'tests': ['a11yr', 15:02:51 INFO - 'ts_paint', 15:02:51 INFO - 'tpaint', 15:02:51 INFO - 'sessionrestore', 15:02:51 INFO - 'sessionrestore_no_auto_restore']}, 15:02:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:02:51 INFO - 'tests': ['a11yr', 15:02:51 INFO - 'ts_paint', 15:02:51 INFO - 'tpaint', 15:02:51 INFO - 'sessionrestore', 15:02:51 INFO - 'sessionrestore_no_auto_restore']}, 15:02:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:02:51 INFO - 'tests': ['a11yr', 15:02:51 INFO - 'ts_paint', 15:02:51 INFO - 'tpaint', 15:02:51 INFO - 'sessionrestore', 15:02:51 INFO - 'sessionrestore_no_auto_restore']}, 15:02:51 INFO - 'other_l64': {'tests': ['a11yr', 15:02:51 INFO - 'ts_paint', 15:02:51 INFO - 'tpaint', 15:02:51 INFO - 'sessionrestore', 15:02:51 INFO - 'sessionrestore_no_auto_restore']}, 15:02:51 INFO - 'other_nol64': {'tests': ['a11yr', 15:02:51 INFO - 'ts_paint', 15:02:51 INFO - 'tpaint', 15:02:51 INFO - 'sessionrestore', 15:02:51 INFO - 'sessionrestore_no_auto_restore']}, 15:02:51 INFO - 'svgr': {'tests': ['tsvgx', 15:02:51 INFO - 'tsvgr_opacity', 15:02:51 INFO - 'tart', 15:02:51 INFO - 'tscrollx', 15:02:51 INFO - 'cart']}, 15:02:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:02:51 INFO - 'tests': ['tsvgx', 15:02:51 INFO - 'tsvgr_opacity', 15:02:51 INFO - 'tart', 15:02:51 INFO - 'tscrollx', 15:02:51 INFO - 'cart']}, 15:02:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:51 INFO - 'tests': ['tp5o']}, 15:02:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:51 INFO - 'talos_options': ['--e10s'], 15:02:51 INFO - 'tests': ['tp5o']}, 15:02:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:51 INFO - 'talos_options': ['--xperf_path', 15:02:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:51 INFO - 'tests': ['tp5n']}, 15:02:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:51 INFO - 'talos_options': ['--e10s', 15:02:51 INFO - '--xperf_path', 15:02:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:51 INFO - 'tests': ['tp5n']}}, 15:02:51 INFO - 'talos.zip': {'path': '', 15:02:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:02:51 INFO - Running post-action listener: _resource_record_post_action 15:02:51 INFO - ##### 15:02:51 INFO - ##### Running create-virtualenv step. 15:02:51 INFO - ##### 15:02:51 INFO - Running pre-action listener: _resource_record_pre_action 15:02:51 INFO - Running main action method: create_virtualenv 15:02:51 INFO - Creating virtualenv /builds/slave/test/build/venv 15:02:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:02:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:02:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:02:51 INFO - Using real prefix '/usr' 15:02:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:02:52 INFO - Installing distribute.............................................................................................................................................................................................done. 15:02:54 INFO - Installing pip.................done. 15:02:54 INFO - Return code: 0 15:02:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9999652c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c91900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd7b70>, '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 0x2d28dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d29250>, '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': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:02:54 INFO - Using env: {'DISPLAY': ':0', 15:02:54 INFO - 'HOME': '/home/cltbld', 15:02:54 INFO - 'LANG': 'en_US.UTF-8', 15:02:54 INFO - 'LANGUAGE': 'en_US:en', 15:02:54 INFO - 'LOGNAME': 'cltbld', 15:02:54 INFO - 'MAIL': '/var/mail/cltbld', 15:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:54 INFO - 'MOZ_NO_REMOTE': '1', 15:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:54 INFO - 'NO_EM_RESTART': '1', 15:02:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:54 INFO - 'PWD': '/builds/slave/test', 15:02:54 INFO - 'SHELL': '/bin/bash', 15:02:54 INFO - 'SHLVL': '1', 15:02:54 INFO - 'TERM': 'linux', 15:02:54 INFO - 'TMOUT': '86400', 15:02:54 INFO - 'USER': 'cltbld', 15:02:54 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 15:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:54 INFO - '_': '/tools/buildbot/bin/python'} 15:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:02:54 INFO - Cleaning up... 15:02:54 INFO - Return code: 0 15:02:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9999652c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c91900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd7b70>, '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 0x2d28dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d29250>, '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': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:02:54 INFO - Using env: {'DISPLAY': ':0', 15:02:54 INFO - 'HOME': '/home/cltbld', 15:02:54 INFO - 'LANG': 'en_US.UTF-8', 15:02:54 INFO - 'LANGUAGE': 'en_US:en', 15:02:54 INFO - 'LOGNAME': 'cltbld', 15:02:54 INFO - 'MAIL': '/var/mail/cltbld', 15:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:54 INFO - 'MOZ_NO_REMOTE': '1', 15:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:54 INFO - 'NO_EM_RESTART': '1', 15:02:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:54 INFO - 'PWD': '/builds/slave/test', 15:02:54 INFO - 'SHELL': '/bin/bash', 15:02:54 INFO - 'SHLVL': '1', 15:02:54 INFO - 'TERM': 'linux', 15:02:54 INFO - 'TMOUT': '86400', 15:02:54 INFO - 'USER': 'cltbld', 15:02:54 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 15:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:54 INFO - '_': '/tools/buildbot/bin/python'} 15:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:54 INFO - Downloading/unpacking psutil>=0.7.1 15:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:02:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:02:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:56 INFO - Installing collected packages: psutil 15:02:56 INFO - Running setup.py install for psutil 15:02:56 INFO - building 'psutil._psutil_linux' extension 15:02:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:02:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:02:56 INFO - building 'psutil._psutil_posix' extension 15:02:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:02:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:02:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:56 INFO - Successfully installed psutil 15:02:56 INFO - Cleaning up... 15:02:57 INFO - Return code: 0 15:02:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9999652c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c91900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd7b70>, '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 0x2d28dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d29250>, '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': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:02:57 INFO - Using env: {'DISPLAY': ':0', 15:02:57 INFO - 'HOME': '/home/cltbld', 15:02:57 INFO - 'LANG': 'en_US.UTF-8', 15:02:57 INFO - 'LANGUAGE': 'en_US:en', 15:02:57 INFO - 'LOGNAME': 'cltbld', 15:02:57 INFO - 'MAIL': '/var/mail/cltbld', 15:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:57 INFO - 'MOZ_NO_REMOTE': '1', 15:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:57 INFO - 'NO_EM_RESTART': '1', 15:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:57 INFO - 'PWD': '/builds/slave/test', 15:02:57 INFO - 'SHELL': '/bin/bash', 15:02:57 INFO - 'SHLVL': '1', 15:02:57 INFO - 'TERM': 'linux', 15:02:57 INFO - 'TMOUT': '86400', 15:02:57 INFO - 'USER': 'cltbld', 15:02:57 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 15:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:57 INFO - '_': '/tools/buildbot/bin/python'} 15:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:02:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:02:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:02:58 INFO - Installing collected packages: mozsystemmonitor 15:02:58 INFO - Running setup.py install for mozsystemmonitor 15:02:59 INFO - Successfully installed mozsystemmonitor 15:02:59 INFO - Cleaning up... 15:02:59 INFO - Return code: 0 15:02:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:02: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')]} 15:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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')]} 15:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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', '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 0x7f9999652c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c91900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd7b70>, '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 0x2d28dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d29250>, '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': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:02: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 blobuploader==1.2.4 15:02:59 INFO - Using env: {'DISPLAY': ':0', 15:02:59 INFO - 'HOME': '/home/cltbld', 15:02:59 INFO - 'LANG': 'en_US.UTF-8', 15:02:59 INFO - 'LANGUAGE': 'en_US:en', 15:02:59 INFO - 'LOGNAME': 'cltbld', 15:02:59 INFO - 'MAIL': '/var/mail/cltbld', 15:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:59 INFO - 'MOZ_NO_REMOTE': '1', 15:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:59 INFO - 'NO_EM_RESTART': '1', 15:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:59 INFO - 'PWD': '/builds/slave/test', 15:02:59 INFO - 'SHELL': '/bin/bash', 15:02:59 INFO - 'SHLVL': '1', 15:02:59 INFO - 'TERM': 'linux', 15:02:59 INFO - 'TMOUT': '86400', 15:02:59 INFO - 'USER': 'cltbld', 15:02:59 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 15:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:59 INFO - '_': '/tools/buildbot/bin/python'} 15:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:59 INFO - Downloading/unpacking blobuploader==1.2.4 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:02: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 15:03:00 INFO - Downloading blobuploader-1.2.4.tar.gz 15:03:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:03:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:03:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:01 INFO - Downloading docopt-0.6.1.tar.gz 15:03:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:03:01 INFO - Installing collected packages: blobuploader, requests, docopt 15:03:01 INFO - Running setup.py install for blobuploader 15:03:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:03:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:03:01 INFO - Running setup.py install for requests 15:03:02 INFO - Running setup.py install for docopt 15:03:02 INFO - Successfully installed blobuploader requests docopt 15:03:02 INFO - Cleaning up... 15:03:02 INFO - Return code: 0 15:03:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:02 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 0x7f9999652c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c91900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd7b70>, '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 0x2d28dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d29250>, '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': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:03:02 INFO - Using env: {'DISPLAY': ':0', 15:03:02 INFO - 'HOME': '/home/cltbld', 15:03:02 INFO - 'LANG': 'en_US.UTF-8', 15:03:02 INFO - 'LANGUAGE': 'en_US:en', 15:03:02 INFO - 'LOGNAME': 'cltbld', 15:03:02 INFO - 'MAIL': '/var/mail/cltbld', 15:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:02 INFO - 'MOZ_NO_REMOTE': '1', 15:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:02 INFO - 'NO_EM_RESTART': '1', 15:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:02 INFO - 'PWD': '/builds/slave/test', 15:03:02 INFO - 'SHELL': '/bin/bash', 15:03:02 INFO - 'SHLVL': '1', 15:03:02 INFO - 'TERM': 'linux', 15:03:02 INFO - 'TMOUT': '86400', 15:03:02 INFO - 'USER': 'cltbld', 15:03:02 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 15:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:02 INFO - '_': '/tools/buildbot/bin/python'} 15:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:02 INFO - Running setup.py (path:/tmp/pip-PPlejI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:02 INFO - Running setup.py (path:/tmp/pip-ZMDmLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:02 INFO - Running setup.py (path:/tmp/pip-86BFmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:02 INFO - Running setup.py (path:/tmp/pip-PODd5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:02 INFO - Running setup.py (path:/tmp/pip-1I_s1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:02 INFO - Running setup.py (path:/tmp/pip-qs2t39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:02 INFO - Running setup.py (path:/tmp/pip-sPVBED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:02 INFO - Running setup.py (path:/tmp/pip-TdXcae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:03 INFO - Running setup.py (path:/tmp/pip-MLK6bX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:03 INFO - Running setup.py (path:/tmp/pip-wD0aRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:03 INFO - Running setup.py (path:/tmp/pip-4Zm8NE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:03 INFO - Running setup.py (path:/tmp/pip-xLYokN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:03 INFO - Running setup.py (path:/tmp/pip-v0s5tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:03 INFO - Running setup.py (path:/tmp/pip-QSfp8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:03 INFO - Running setup.py (path:/tmp/pip-N1EPxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:03 INFO - Running setup.py (path:/tmp/pip-zklJVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:03 INFO - Running setup.py (path:/tmp/pip-KUVTPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:03:03 INFO - Running setup.py install for manifestparser 15:03:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:03:03 INFO - Running setup.py install for mozcrash 15:03:03 INFO - Running setup.py install for mozdebug 15:03:03 INFO - Running setup.py install for mozdevice 15:03:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:03:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:03:04 INFO - Running setup.py install for mozfile 15:03:04 INFO - Running setup.py install for mozhttpd 15:03:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:03:04 INFO - Running setup.py install for mozinfo 15:03:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:03:04 INFO - Running setup.py install for mozInstall 15:03:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:03:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:03:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:03:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:03:04 INFO - Running setup.py install for mozleak 15:03:04 INFO - Running setup.py install for mozlog 15:03:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:03:04 INFO - Running setup.py install for moznetwork 15:03:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:03:04 INFO - Running setup.py install for mozprocess 15:03:04 INFO - Running setup.py install for mozprofile 15:03:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:03:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:03:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:03:05 INFO - Running setup.py install for mozrunner 15:03:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:03:05 INFO - Running setup.py install for mozscreenshot 15:03:05 INFO - Running setup.py install for moztest 15:03:05 INFO - Running setup.py install for mozversion 15:03:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:03:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:03:05 INFO - Cleaning up... 15:03:05 INFO - Return code: 0 15:03:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f9999652c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c91900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd7b70>, '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 0x2d28dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d29250>, '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': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:03:05 INFO - Using env: {'DISPLAY': ':0', 15:03:05 INFO - 'HOME': '/home/cltbld', 15:03:05 INFO - 'LANG': 'en_US.UTF-8', 15:03:05 INFO - 'LANGUAGE': 'en_US:en', 15:03:05 INFO - 'LOGNAME': 'cltbld', 15:03:05 INFO - 'MAIL': '/var/mail/cltbld', 15:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:05 INFO - 'MOZ_NO_REMOTE': '1', 15:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:05 INFO - 'NO_EM_RESTART': '1', 15:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:05 INFO - 'PWD': '/builds/slave/test', 15:03:05 INFO - 'SHELL': '/bin/bash', 15:03:05 INFO - 'SHLVL': '1', 15:03:05 INFO - 'TERM': 'linux', 15:03:05 INFO - 'TMOUT': '86400', 15:03:05 INFO - 'USER': 'cltbld', 15:03:05 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 15:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:05 INFO - '_': '/tools/buildbot/bin/python'} 15:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:05 INFO - Running setup.py (path:/tmp/pip-waKOx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:05 INFO - Running setup.py (path:/tmp/pip-ptAlE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:05 INFO - Running setup.py (path:/tmp/pip-dwRihc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:05 INFO - Running setup.py (path:/tmp/pip-3rI8B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:05 INFO - Running setup.py (path:/tmp/pip-xep4IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:06 INFO - Running setup.py (path:/tmp/pip-poS4hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:06 INFO - Running setup.py (path:/tmp/pip-J3HbBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:06 INFO - Running setup.py (path:/tmp/pip-U4Sj14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:06 INFO - Running setup.py (path:/tmp/pip-XvBTjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:06 INFO - Running setup.py (path:/tmp/pip-RTBRvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:06 INFO - Running setup.py (path:/tmp/pip-vBpKJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:06 INFO - Running setup.py (path:/tmp/pip-WTYDCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:06 INFO - Running setup.py (path:/tmp/pip-yK36po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:06 INFO - Running setup.py (path:/tmp/pip-B0Q3Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:06 INFO - Running setup.py (path:/tmp/pip-xBHurM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:06 INFO - Running setup.py (path:/tmp/pip-SyXgrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:06 INFO - Running setup.py (path:/tmp/pip-a0Yikh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:03:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03: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 15:03:08 INFO - Downloading blessings-1.5.1.tar.gz 15:03:08 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:03:08 INFO - Installing collected packages: blessings 15:03:08 INFO - Running setup.py install for blessings 15:03:08 INFO - Successfully installed blessings 15:03:08 INFO - Cleaning up... 15:03:08 INFO - Return code: 0 15:03:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:03:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:08 INFO - Reading from file tmpfile_stdout 15:03:08 INFO - Current package versions: 15:03:08 INFO - argparse == 1.2.1 15:03:08 INFO - blessings == 1.5.1 15:03:08 INFO - blobuploader == 1.2.4 15:03:08 INFO - docopt == 0.6.1 15:03:08 INFO - manifestparser == 1.1 15:03:08 INFO - mozInstall == 1.12 15:03:08 INFO - mozcrash == 0.16 15:03:08 INFO - mozdebug == 0.1 15:03:08 INFO - mozdevice == 0.47 15:03:08 INFO - mozfile == 1.2 15:03:08 INFO - mozhttpd == 0.7 15:03:08 INFO - mozinfo == 0.9 15:03:08 INFO - mozleak == 0.1 15:03:08 INFO - mozlog == 3.0 15:03:08 INFO - moznetwork == 0.27 15:03:08 INFO - mozprocess == 0.22 15:03:08 INFO - mozprofile == 0.27 15:03:08 INFO - mozrunner == 6.11 15:03:08 INFO - mozscreenshot == 0.1 15:03:08 INFO - mozsystemmonitor == 0.0 15:03:08 INFO - moztest == 0.7 15:03:08 INFO - mozversion == 1.4 15:03:08 INFO - psutil == 3.1.1 15:03:08 INFO - requests == 1.2.3 15:03:08 INFO - wsgiref == 0.1.2 15:03:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:08 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 0x7f9999652c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be06c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c91900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd7b70>, '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 0x2d28dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d29250>, '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': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:03:09 INFO - Using env: {'DISPLAY': ':0', 15:03:09 INFO - 'HOME': '/home/cltbld', 15:03:09 INFO - 'LANG': 'en_US.UTF-8', 15:03:09 INFO - 'LANGUAGE': 'en_US:en', 15:03:09 INFO - 'LOGNAME': 'cltbld', 15:03:09 INFO - 'MAIL': '/var/mail/cltbld', 15:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:09 INFO - 'MOZ_NO_REMOTE': '1', 15:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:09 INFO - 'NO_EM_RESTART': '1', 15:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:09 INFO - 'PWD': '/builds/slave/test', 15:03:09 INFO - 'SHELL': '/bin/bash', 15:03:09 INFO - 'SHLVL': '1', 15:03:09 INFO - 'TERM': 'linux', 15:03:09 INFO - 'TMOUT': '86400', 15:03:09 INFO - 'USER': 'cltbld', 15:03:09 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 15:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:09 INFO - '_': '/tools/buildbot/bin/python'} 15:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:09 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 1)) 15:03:09 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 2)) 15:03:09 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 3)) 15:03:09 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 4)) 15:03:09 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 5)) 15:03:09 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 6)) 15:03:09 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 7)) 15:03:09 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 8)) 15:03:09 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:03:09 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 3)) 15:03:09 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:03:09 INFO - Cleaning up... 15:03:09 INFO - Return code: 0 15:03:09 INFO - Running post-action listener: _resource_record_post_action 15:03:09 INFO - Running post-action listener: _start_resource_monitoring 15:03:09 INFO - Starting resource monitoring. 15:03:09 INFO - ##### 15:03:09 INFO - ##### Running install step. 15:03:09 INFO - ##### 15:03:09 INFO - Running pre-action listener: _resource_record_pre_action 15:03:09 INFO - Running main action method: install 15:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:09 INFO - Reading from file tmpfile_stdout 15:03:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:03:09 INFO - Reading from file tmpfile_stdout 15:03:09 INFO - Output received: 15:03:09 INFO - Usage: mozinstall [options] installer 15:03:09 INFO - Options: 15:03:09 INFO - -h, --help show this help message and exit 15:03:09 INFO - -d DEST, --destination=DEST 15:03:09 INFO - Directory to install application into. [default: 15:03:09 INFO - "/builds/slave/test"] 15:03:09 INFO - --app=APP Application being installed. [default: firefox] 15:03:09 INFO - mkdir: /builds/slave/test/build/application 15:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:03:24 INFO - Reading from file tmpfile_stdout 15:03:24 INFO - Output received: 15:03:24 INFO - /builds/slave/test/build/application/firefox/firefox 15:03:24 INFO - Running post-action listener: _resource_record_post_action 15:03:24 INFO - ##### 15:03:24 INFO - ##### Running run-tests step. 15:03:24 INFO - ##### 15:03:24 INFO - Running pre-action listener: _resource_record_pre_action 15:03:24 INFO - Running main action method: run_tests 15:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:03:24 INFO - Python 2.7.3 15:03:24 INFO - Return code: 0 15:03:24 INFO - grabbing minidump binary from tooltool 15:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:24 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 0x2cd7b70>, '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 0x2d28dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d29250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:03:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:03:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:03:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:03:24 INFO - Return code: 0 15:03:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:03:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:03:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:03:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:03:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test/build 15:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 15:03:24 INFO - Using env: {'DISPLAY': ':0', 15:03:24 INFO - 'HOME': '/home/cltbld', 15:03:24 INFO - 'LANG': 'en_US.UTF-8', 15:03:24 INFO - 'LANGUAGE': 'en_US:en', 15:03:24 INFO - 'LOGNAME': 'cltbld', 15:03:24 INFO - 'MAIL': '/var/mail/cltbld', 15:03:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:03:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:24 INFO - 'MOZ_NO_REMOTE': '1', 15:03:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:24 INFO - 'NO_EM_RESTART': '1', 15:03:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:24 INFO - 'PWD': '/builds/slave/test', 15:03:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:03:24 INFO - 'SHELL': '/bin/bash', 15:03:24 INFO - 'SHLVL': '1', 15:03:24 INFO - 'TERM': 'linux', 15:03:24 INFO - 'TMOUT': '86400', 15:03:24 INFO - 'USER': 'cltbld', 15:03:24 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021', 15:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:24 INFO - '_': '/tools/buildbot/bin/python'} 15:03:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 15:03:24 INFO - mozversion INFO | application_buildid: 20151119141035 15:03:24 INFO - mozversion INFO | application_changeset: 87191bd52446546f2427d4d2d524792aa15964fa 15:03:24 INFO - mozversion INFO | application_display_name: Nightly 15:03:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:03:24 INFO - mozversion INFO | application_name: Firefox 15:03:24 INFO - mozversion INFO | application_remotingname: firefox 15:03:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:03:24 INFO - mozversion INFO | application_vendor: Mozilla 15:03:24 INFO - mozversion INFO | application_version: 45.0a1 15:03:24 INFO - mozversion INFO | platform_buildid: 20151119141035 15:03:24 INFO - mozversion INFO | platform_changeset: 87191bd52446546f2427d4d2d524792aa15964fa 15:03:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:03:24 INFO - mozversion INFO | platform_version: 45.0a1 15:03:24 INFO - 2015-11-19 15:03:24,455 DEBUG : using testdate: 1447974204 15:03:24 INFO - 2015-11-19 15:03:24,455 DEBUG : actual date: 1447974204 15:03:24 INFO - 2015-11-19 15:03:24,463 INFO : starting webserver on 'localhost:51981' 15:03:24 INFO - 2015-11-19 15:03:24,464 INFO : Starting test suite talos-linux64-ix-008 15:03:24 INFO - 2015-11-19 15:03:24,464 INFO : Starting test dromaeo_css 15:03:24 INFO - 2015-11-19 15:03:24,465 DEBUG : operating with platform_type : linux_ 15:03:24 INFO - 2015-11-19 15:03:24,465 INFO : Initialising browser for dromaeo_css test... 15:03:24 INFO - 2015-11-19 15:03:24,479 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWmHe_l/profile http://localhost:51981/getInfo.html 15:03:30 INFO - 2015-11-19 15:03:30,058 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:03:30 INFO - 2015-11-19 15:03:30,058 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:03:30 INFO - 2015-11-19 15:03:30,058 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:03:30 INFO - 2015-11-19 15:03:30,058 DEBUG : BROWSER_OUTPUT: __metrics 15:03:30 INFO - 2015-11-19 15:03:30,122 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:03:31 INFO - 2015-11-19 15:03:31,484 INFO : Browser initialized. 15:03:31 INFO - 2015-11-19 15:03:31,485 INFO : Running cycle 1/1 for dromaeo_css test... 15:03:31 INFO - 2015-11-19 15:03:31,485 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWmHe_l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:03:43 INFO - 2015-11-19 15:03:43,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 142118912 15:03:43 INFO - 2015-11-19 15:03:43,408 DEBUG : BROWSER_OUTPUT: 15:04:34 INFO - 2015-11-19 15:04:34,817 DEBUG : BROWSER_OUTPUT: 1447974274816 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:06:46 INFO - 2015-11-19 15:06:46,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51981/tests/dromaeo/cssquery-ext.html) 15:06:48 INFO - 2015-11-19 15:06:48,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 244985856 15:06:48 INFO - 2015-11-19 15:06:48,134 DEBUG : BROWSER_OUTPUT: 15:09:50 INFO - 2015-11-19 15:09:50,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/dromaeo/cssquery-ext.html (next: http://localhost:51981/tests/dromaeo/cssquery-jquery.html) 15:09:51 INFO - 2015-11-19 15:09:51,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 225345536 15:09:51 INFO - 2015-11-19 15:09:51,236 DEBUG : BROWSER_OUTPUT: 15:12:53 INFO - 2015-11-19 15:12:53,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51981/tests/dromaeo/cssquery-mootools.html) 15:12:53 INFO - 2015-11-19 15:12:53,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 221134848 15:12:53 INFO - 2015-11-19 15:12:53,794 DEBUG : BROWSER_OUTPUT: 15:15:55 INFO - 2015-11-19 15:15:55,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51981/tests/dromaeo/cssquery-prototype.html) 15:15:56 INFO - 2015-11-19 15:15:56,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 202825728 15:15:56 INFO - 2015-11-19 15:15:56,416 DEBUG : BROWSER_OUTPUT: 15:18:59 INFO - 2015-11-19 15:18:59,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51981/tests/dromaeo/cssquery-yui.html) 15:18:59 INFO - 2015-11-19 15:18:59,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 205082624 15:18:59 INFO - 2015-11-19 15:18:59,780 DEBUG : BROWSER_OUTPUT: 15:22:02 INFO - 2015-11-19 15:22:02,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/dromaeo/cssquery-yui.html (next: http://localhost:51981/tests/dromaeo/cssquery-dojo.html) 15:22:02 INFO - 2015-11-19 15:22:02,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 252997632 15:22:02 INFO - 2015-11-19 15:22:02,731 DEBUG : BROWSER_OUTPUT: 15:22:02 INFO - 2015-11-19 15:22:02,732 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:22:02 INFO - 2015-11-19 15:22:02,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:22:02 INFO - 2015-11-19 15:22:02,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:22:02 INFO - 2015-11-19 15:22:02,732 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:22:02 INFO - 2015-11-19 15:22:02,736 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2614.5163144818207;2715.1854443666894;2715.524783162946;2726.1685186018267;2739.561670132779;4526.298423744317;4651.372064771255;4737.763111844407;4772.451168115667;4784.210605250134;4662.743549104798;4676.836310729125;4701.106789709961;4749.26386410107;4780.211265141247;4352.325389564622;4356.520782713907;4382.233109205892;4401.383806267125;4401.405810215628;4458.97770511147;4499.640028797705;4507.301368287905;4516.683832131752;4531.886702832423;4273.978630106845;4333.328334108218;4406.713563618355;4408.845690400853;4426.402435671175;4378.78106094694;4389.626881715058;4396.494403143615;4418.204723149832;4420.535843736394;4342.6742994275555;4348.412964249817;4356.463318459084;4359.215341238576;4389.012472193763;4515.548445155491;4516.706414083074;4656.231721765905;4665.510121437268;4693.718376897397;5128.025675121715;5164.819231326923;5194.324737784102;5206.687598744087;5210.817621383233;5203.505666961671;5218;5222.451642577513;5240.659357141812;5285.127953887642;4549.613282870993;4670;4677.345171675968;4834.540718631724;4836.322914791932;5085.313482679865;5167.6641018333685;5174.353205849269;5218.217267409843;5230.529252367305;4995.500449955048;5001.64988450805;5006.224035274538;5046.62150338726;5058.291839142523;4881.975590122027;4990.3762029746285;4991.6006719463085;5083.491650834961;5103.897922041612;5003.774830132653;5054;5059.620528460307;5070.6957582545165;5074.720890351066;5077.720725360141;5139.306193663808;5139.9720055988955;5142.280080788692;5191.714455704972;4075.38869169621;4181.853635122817;4185.22573323936;4320.43834301545;4334.848280310174;3698.4267438547067;3745.176061266517;3763.2097259575794;3778.131029863147;3794.165283637595;4400.537943515948;4410.889727756768;4411.18393097278;4412.448443944507;4450.532694067141;4962.925556116661;5106.157484015096;5108.182690769459;5156.071907056691;5209.322788037531;4269.146170765859;4307.741535507879;4315.741055536678;4335.176316499855;4353.82584696615;4550.681452298308;4556.658250631216;4564.041551274203;4567.1779079765965;4606.124836281096;4642.094791515622;4737.976310118565;4758.809647614056;4877.3903262092235;4878.634102442331;4946.35697359341;5003.474635163256;5024.171011783015;5028.949710502849;5079.77141028662;4829.710217386968;4834.8791280218275;4843.660943733905;4864.951350486592;4882.2432522959;4787.952120478751;4897.363342765418;4899.706017638953;5040.067587496325;5076.593872490118;5087.898242035212;5187;5203.713795741119;5204.427512973494;5207.661502002357;4898.730569818694;4905.637852303528;4912.6561140719805;4913.852584422473;4941.234108713155;4703.74129422885;4762.904741905212;4897.289892965571;4909.214525675875;4947.109520286383;4705.5059218781535;4735.573798358164;4797.664163508521;4815.2054910939305;4844.297576851407;4954.504549545017;4995.575376093073;4996.250562415521;5034.723090230073;5048.974755126348;4659.603933665677;4786.593139583175;4895;4909.1654418748185;4910.656254062182 15:22:02 INFO - 2015-11-19 15:22:02,737 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.1851886985565;566.6600039976014;573.372157487551;578.5342799046769;586.1442294250394;26266.737332626668;26849.328766780814;35526.99999999997;36552;36561.26877462449;39973.800130999305;40326;40468.19063618726;40482.39276410856;40541.98645033876;6905.965470172642;7837.373010159188;8005.959970200141;8006.519608823489;8007.719729809458;6977.3022697730075;7067.575945443265;7069.540479868792;7071.893921591154;10021.44882031488;10002.749931251741;10097.747556311115;10103.797924041515;10108.747281317952;10114.74713132174;9793.314467987244;9842.753931151707;9878.703638890809;9899.208063354914;9908.355956862853;7059.2234854166;7241.5293005954445;10015.298929074968;10317.9484102579;10331.27681062326;36451;36975.63024369749;37027.62972370296;37035.44446833299;37102.62897371019;2728.890844366223;2774.1677496750895;2825.6185414969127;2838.4606924684244;2987.656419511762;28298.575521367195;28747.28131796701;28781.42437151266;28974.420511589862;29136.41727165466;3374.416656694998;3468.1329667583104;3486.267883744417;3547.592026916912;3589;215335.76996345067;216402;216541;216542;216830;55279.72360138254;55741.72129139328;55773;55774.442255577735;55796.16305755417;49318;50514.49485505098;63931.36068639347;65523;65695.67152164305;11881.881181188077;11905.642830715093;11917.22538035025;11978.92189702931;11980.700482487833;9772.560234789451;9816.411015339103;9817.803643927224;9842.261830362751;9861.753456163653;18734.156962936428;18943;19023.429297121107;19045;19053.42839714811;7335.1197856257595;7681.731139410093;7766.184550622103;7849.215078492105;7856.09654889695;807.6083099696642;892.1034360467818;920.130476699526;958.8513780364054;1049.1921220660201;26953.730462695516;27208.425886640194;27245.455090898467;27400.314992124957;27504.862475687893;951.2770294576172;957.9856302155473;972.2999440402899;996.3872218585518;1029.3360782295379;14126.939745561327;14139.64650883736;14237.857621423653;14267;14376.856231437761;266065;269905;270132;270148;271000;37916.052098697204;47195.764021179675;47479;47574;47638.28542571864;1083.1443159903745;1108.174410064491;1137.4710759496709;1151.694800877768;1153.0890596428728;24169.154079607128;24313;24792.752072479045;24821.50356992886;24851.502969940862;35517.82241088778;36556;36874.44688329624;37559.43660845144;42339;161320.19339903226;161465;162402;162669.18665406597;162738;26784.732152678225;27065.052723154597;27154.592681109403;27176.456470870868;27194.184174474798;37035.6296437043;38293.23413531658;38425.6157438422;39314.80342598269;39319;29757.851210743807;32883.34233315368;33748.66251337554;34012.82993585016;34395.656043439245;29896.25259368533;30058.947936822107;30230.395392092476;32476.350472989936;33895.83052084724;30715.846420767753;31026.224344391572;31078.68921310758;31115.533267001465;33019.33961320808;28439;28559.28601784972;28851.278718032216;28908.566371504025;29233.85383073071;22980.19569315066;23018.884905575364;23170.420739481648;23318.53362932698;23409.180678676166 15:22:02 INFO - 2015-11-19 15:22:02,739 DEBUG : BROWSER_OUTPUT: |2;jquery.html;345.2387485594264;345.29731995389386;345.6992416597559;346.2469129643024;346.91500582357327;12543.435545400456;12968.675783105404;15305.311260993254;15337.309821058052;15796.368145274204;11617.65147045588;13761.65595860104;14763.704725905476;14965.401383944656;14985.175815330153;5057.241413787933;5201.765920533585;5209.426963034063;5209.921851172236;5210.192420174879;3539.681428671419;3630.52803135592;5150.896982060356;5193.16909294513;5195.142801437777;5631.155326700987;5727.770889164429;5767.740451679684;5773.538116950634;5778.3066032076;5298.205269209611;5304.045271851065;5453.182022696587;5725.198472213893;5734.569907256951;5088;5140.460251673558;5169.870753231199;5170.1469257572835;5170.896582068375;18374.908125459286;18556.536086597942;18760.24959001638;18763.53091172718;18827.24691012358;1681.6216351320977;1738.3915629529563;1858.3681548273653;1926.807319268062;1956.2272902203692;12602.117851750381;12677.17598356104;12702.872971270353;12798.296093714842;12949.935250323782;1680.5889988802708;1703.1484257871064;1709.4102534625533;1713.6230029393514;1746.8515176210037;51328.48671513312;52966.47033529654;53483.732581336844;53568;53750.73124634391;9390.295727820305;9550.856737148948;9650.758731031781;9708.563114659857;9782.608695652236;12213.267203967791;12253.571125010581;12290.754184916252;12300.938495307646;12306.323152226534;6752.189737231563;6767.424768894699;6769.492288078413;6781.864362712817;6825.590464572141;6305.14880491137;6311.27420346666;6324.9051264231075;6364.968175159094;6366.745330186834;5707.086866101404;5786.334571524329;5789.964261326023;5790.797322093791;5916.2013128228;1562.2110834028742;1637.8116516600505;1667.1747484995005;1668.3410053028986;1678.5551828765388;738.7229788829189;882.5543100734088;920.9777147366418;979.4661909259471;1018.9745256368502;15626.453074142577;16586.75119873203;16848.14721026428;17177.914110429618;17240;770.4183341577074;880.3397451911067;921.0381886581672;941.2187884056217;967.2358836519212;8421.242088211968;8769.736907892773;9195.540222988824;9220.124088211609;9332.040271542915;482396;482902;495980;500449;507929;66763;68356.31643683599;68387;68769.65615171893;69368.6531567339;1077.7682798198425;1080.37338343762;1083.4257843343041;1101.372217835826;1104.2270410712533;14327.355269013127;14388.467707389296;14590.270486475845;14669;14682;31079.533806993364;31616.525752114198;31839.840800795846;32036.839815800773;32431.351372971938;40534.59465405308;40727.1854562913;41538.58461415347;41820.79089604533;41876.371854421595;8805.647774088964;9146.176844084064;9187.908120918706;9211.815763684555;9217.815643687223;15710.371585136467;15933;15983.760243596123;16383.590410239363;16412.753808693116;12915.612531624067;13552.796708049584;13637.590872273848;13726.107802992774;13989;12710.36448177606;13223.933880330536;13283.535076272285;13628.523001694894;13658.453661853811;13258.602241932758;13285.734285314433;13371.39828707691;14099.083559568595;14212.502562410265;7106.609136497542;8195.098539160568;8658.78353041179;8723.781905452415;8747.125287471203;8829;9936;13321.267330296927;13505;13612.8429083529 15:22:02 INFO - 2015-11-19 15:22:02,742 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1218.116865272678;1614.6770645870824;1658.3532422355283;1686.7891513560805;1695.5337282247376;5899.4395532424405;6727.091842601248;6858.828529286758;6867.141607299088;6870.519063665545;7035.542689725165;7131;7145.356917877403;7160.069191005175;7161.462890283224;1730.9134543272849;1765.9381921632746;2022.2113375783383;2063.989680051601;2089.4045197118826;2083.364573804989;2085.1242478159133;2089.60297543467;2089.8328133749264;2090.3519908828234;2019.6768517037276;2053.4147767886157;2060.979390206101;2065.524929266262;2067.648499755045;2021.080408414168;2043.213362855304;2062.247279742898;2074.834013278934;2077.66757318829;2075.30477290108;2076.512019675375;2090.310197634777;2098.8635738676935;2100.537881666031;7025.051618031552;7066.2227155013425;7085.89371159433;7094.11323584552;7107.92892071083;4098.979505102485;4188.748675079505;4192.559781222958;4198.3702444633545;4202.327627579603;2315.247544548012;2719.551274039781;2845.8434786086755;2858.957115643267;2868.641419822522;830.7549272964429;834.7787836223406;883.9116088391173;883.9823203535893;952.4666186935339;9775.51122443875;9791.706248812547;9810.068043535925;9813.901860981441;9837.458939758382;3929.5088113985753;3998.1803730235233;4002.459667944848;4027.335489644176;4041.131156801302;7977.122516523178;8014.438989270695;8017.118117007125;8025.7993550160545;8031.076426210943;4222.0289333453475;4252.043290259667;4259.254630439661;4264.829406823755;4267.1892340455215;3818.8281527331337;3855.0747820523434;3855.267499175148;3856.1130939883983;3856.1709232515145;2976.345204055104;3023.7429818465675;3251.5935508061493;3408.2672225471642;3408.7102596279096;1087.1302957633861;1112.0158659586325;1112.5327362507767;1116.5757012335262;1123.4775829239443;907.8955920069144;968.6077138758814;1150.8446359741495;1179.7463545337794;1181.5746331320718;6701;6720.731170753115;6777.6272305023695;6779.220389655155;6838.555493892881;983.2969426859829;990.2770977186694;1013.2755080117752;1016.8779746430328;1016.9186465082776;5140.742962851842;5184.326037615161;5290.603204759658;5324.627276090714;5346.652467589672;8466.280366168821;8659.523726194993;8740.956295218482;8777.780555486164;8782.912170878337;8082.959585202037;8263.669453221804;8334.20825021622;8639.092895246034;8652.3510736695;6781.4574834013165;6858.417034552019;6873.48448866337;6896.27589103147;6923.6192009438955;6704.262531121671;6769.255381908085;6783.423409010092;6820.727170913108;6831.760888368884;7622.580758058139;7692.230776922263;7794.376449883882;7838.216178382344;7846.5292082475235;7811.648475818715;7874.212578742309;7901.961564476927;7975.282224599814;8007;6442.710078046405;6510.088587597835;6510.251321098134;6512.6092434454085;6535.215774107138;5548.778048878161;5684.971575142098;5691.658500489983;5696.344920334049;6983.301669832976;5677;6048.213732214784;6539.771108011197;6593.571417857824;6600.834979125369;6391.616503009835;6397.456216221487;6441.5490915635455;6488.513361497812;6576.736930522726;6557.475401967736;6577.046328282468;6578.144841170617;6579.111819904251;6595.703193356215;5788.189653448437;6019.127226552213;6055.969720151371;6062.333143354139;6096.359882212481;6003.7898673546215;6034.366391528826;6038.909416358671;6041.697915104315;6057.909131362945 15:22:02 INFO - 2015-11-19 15:22:02,744 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.7080488133832;308.63889249577994;312.4844007387811;318.5269874236757;320.5720363314974;5312.096943519601;5417.539509141728;5418.376886658036;5439.374471935728;5446.700431476267;5306.230596563496;5326.414094449608;5327.2808170896915;5334.359876814778;5341.786328546863;3948.802559872009;4046.8988275293204;4214.599613036772;4220.746755194683;4221.155768846228;4078.9592104078874;4174.97912510437;4190.811413486401;4205.306124489455;4208.032152604903;4158.043649960511;4160.375943608453;4162.063535704473;4163.979180104096;4164.500259968793;3906.7069969752242;4049.898752531181;4052.0680243543857;4053.5946405359227;4168.291390463629;3551.147724546116;3556.199855032623;3590.964090359089;3685.3182161300247;3691.003429074135;5150.510701483353;5157.974210128926;5161.535461808456;5161.5870730341485;5164.406093299281;4800.063987522434;4811.711297322172;4817.0365926814775;4819.397575303087;4823.5176482351835;5506.559475241971;5634.408387119334;5645.717714114319;5651.491365777099;5654.802081927154;4018.8995275118064;4021.597840215955;4021.5978402159844;4023.7988100594853;4028.8187031583357;5914.852128696774;5949.524038076944;5954.46409823118;5959.523238140939;5960.9105863412515;4118.341065429517;4154.335306350969;4154.729942553724;4159.064210552601;4162.604552567501;4118.238125946709;4230.280852255124;4249.46881639795;4251.213525497793;4276.57234276576;4788.7366194859615;4790.281457781361;4791.520847915251;4795.6163506919365;4796.592289655348;5670.829875103754;5672.064109421899;5674.347450043216;5675.120356344773;5679.346875109415;1474.2039298778539;1501.7822415749656;1503.4512402973055;1506.615812967708;1506.8417816129368;1030.6289735695143;1032.6592224565875;1035.7255327338262;1040.7970445763156;1061.1775873697945;4931.802727890844;4954.133026720309;4955.281484184845;4960.627952903475;4965.776540055706;5848.590598658053;5860.677662728591;5861.88276234473;5865.882682346414;5866.882662346815;4947.90104197914;4953.826616068421;4954.950450495521;4958.057968985881;4961.05739909416;2925.8537073146686;2996.10116964914;3111.68883111687;3130.624325081005;3167.255694911694;5519.558435325164;5600.131979543177;5600.551955843523;5604.635698679573;5607.663540187602;6064.393560643988;6082.635041897412;6084.574079814371;6088.178095957078;6091.786787462417;5577.191307260425;5583.69289689071;5591.10542313228;5591.3569939456665;5591.608587398843;5778.16216648592;5866.6480011199465;5892;5910.911336330045;5916.378780228014;5763.884722305446;5773.336066352424;5782.045962416154;5782.306123265235;5789.56578256624;5578;5579.218909352775;5581.665100094007;5585.748641311069;5587.329520457572;4113.794310284534;4190.497140343056;4196.9370459442525;4197.664186865105;4214.346776249687;5897.026990546512;5910.231669882888;5912.142739302863;5917.201177840936;5924;5614.07367784311;5614.63504872182;5615.438456154352;5618.550515958796;5623.044082506066;5608.803691870765;5614.04561224601;5621.494065534122;5623.606347555632;5627.0715331971405;5288.3918349390315;5534.861628459321;5559.16612508127;5575.972120139373;5582.27430434041;5670.858228544319;5695.145728140812;5699.349802341765;5709.429057094258;5715.428457154251;5294.100002999422;5420.647657902224;5458.1266997280245;5541.473560011793;5543.722813859372 15:22:02 INFO - 2015-11-19 15:22:02,745 DEBUG : BROWSER_OUTPUT: |5;yui.html;746.4364404874319;747.4991755523798;754.1101500229728;771.4522688890887;773.0684525147195;11052.557897684093;11411;11756.823647645293;11977.64067077989;11981.640550783468;12633.052521060912;12900;12936.741265174714;12955;13039.804402933964;605.5125623872781;614.5575185866169;615.5567991046439;774.0749803984241;788.8304014636852;619.1023016625888;621.8196722950339;624.5596854217788;775.042822114688;789.9802504937365;811.4603788480654;818.0796603820702;822.880682301066;823.2426167925523;826.8139668574582;629.7418058595954;810.6392655268407;810.8580998325328;811.1158836867813;812.1229072601576;473.9976300118512;590.7755053079845;601.1974014690394;602.5510994309224;602.7769725201659;11510.30938143714;11737.178397512092;11758.412079395996;11761.41192940358;11806.350650714206;10722.981316774894;10881.510332035077;10974.396408197546;11263;11369.602063927723;9415.670451534163;9614.807703845954;9809.313348065638;9843.803123937552;10128.442935638537;3178.284885900677;3193.1538142392283;3207.06994971458;3273.116258610186;3347.397468455677;39856;39984.20031599381;39996.40005399892;40001.399979000336;40071.39892901609;9089.136532029446;9249.861252081224;9291.953540232256;9398.436093834393;9412.858807117898;15666.764998525032;15673.294701738449;15682.215889205494;15688;15691.843081569266;6055.273367195965;6086.969565152234;6099.207103076572;6386.904196437057;6472.546921715435;3494.2836718472654;3587.264610754789;3600.6759391654355;3627.6553727395853;3667.4132138857653;2725.3731641722516;2750.2849259192353;2755.8484283364205;2758.655168103987;2761.0750398616287;483.24131114151146;492.3058487532562;522.193211488244;536.0431629541328;539.3527766679921;614.5698011392044;628.7767842415968;635.5424094651843;639.2009987515605;639.3702203329716;7396.260373962561;7782.143964163937;7922.049354077548;8226.670933162726;8653.480791152551;474.49703314486754;516.1406258579498;593.9673317967466;595.6426144313377;633.3002032753833;3466.168119651316;3511.455724362728;3569.821508924543;3630.3828349180703;3652.6164752701116;49037.509624903294;49471.28965327615;49552.50447495551;49580;49614;41547.169056618695;42099;43278.56721432808;43319.133617327476;43742.343864842056;39249.21501569953;40232.79883600563;41072.9999999994;41392.79303603523;41418.792906035276;7768.184340644377;7801.9609901950125;8005.319547838499;8037.035555733116;8193.303569196685;32631.347373051933;33057.173570660925;33452;33591.496127558596;33705.49441758425;36835.26329473449;36974.26051478901;41277.587224127376;41810;42397.576024239366;9928.205743540355;9944.751381215527;9951.850722239316;9969.152622027208;10165.745856353651;10182.949085254822;10665.733356666145;11004.504797284302;11063.668089957315;11075.390853502813;10047.648332308334;10076;10440.269181157246;10653.360798352123;10730.62442814529;10070.093691567794;10275;10282.742931426774;10518.789624207626;10581.576736930436;10002.399856008662;10457.111145552713;10496.212784041074;10564.735881603021;10599.205059620404;8367.07962124178;8367.832643347221;8417.537035463109;8447.324214062983;8476.194761497647;8510.276626486819;8777.956110219407;8943.23982461472;8949.463032218087;8996.235319997873 15:22:02 INFO - 2015-11-19 15:22:02,745 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:22:02 INFO - 2015-11-19 15:22:02,745 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:22:02 INFO - 2015-11-19 15:22:02,745 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,940 15:22:02 INFO - 2015-11-19 15:22:02,745 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:22:02 INFO - 2015-11-19 15:22:02,745 DEBUG : BROWSER_OUTPUT: __startTimestamp1447975322731__endTimestamp 15:22:02 INFO - 2015-11-19 15:22:02,746 DEBUG : BROWSER_OUTPUT: 15:22:02 INFO - 2015-11-19 15:22:02,746 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:22:02 INFO - 2015-11-19 15:22:02,746 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:22:02 INFO - 2015-11-19 15:22:02,746 DEBUG : BROWSER_OUTPUT: 15:22:02 INFO - 2015-11-19 15:22:02,746 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4690.47 Median:4787.95 stddev:492.60 (10.3%) stddev-sans-first:466.41 15:22:02 INFO - 2015-11-19 15:22:02,747 DEBUG : BROWSER_OUTPUT: Values: 2614.5 2715.2 2715.5 2726.2 2739.6 4526.3 4651.4 4737.8 4772.5 4784.2 4662.7 4676.8 4701.1 4749.3 4780.2 4352.3 4356.5 4382.2 4401.4 4401.4 4459.0 4499.6 4507.3 4516.7 4531.9 4274.0 4333.3 4406.7 4408.8 4426.4 4378.8 4389.6 4396.5 4418.2 4420.5 4342.7 4348.4 4356.5 4359.2 4389.0 4515.5 4516.7 4656.2 4665.5 4693.7 5128.0 5164.8 5194.3 5206.7 5210.8 5203.5 5218.0 5222.5 5240.7 5285.1 4549.6 4670.0 4677.3 4834.5 4836.3 5085.3 5167.7 5174.4 5218.2 5230.5 4995.5 5001.6 5006.2 5046.6 5058.3 4882.0 4990.4 4991.6 5083.5 5103.9 5003.8 5054.0 5059.6 5070.7 5074.7 5077.7 5139.3 5140.0 5142.3 5191.7 4075.4 4181.9 4185.2 4320.4 4334.8 3698.4 3745.2 3763.2 3778.1 3794.2 4400.5 4410.9 4411.2 4412.4 4450.5 4962.9 5106.2 5108.2 5156.1 5209.3 4269.1 4307.7 4315.7 4335.2 4353.8 4550.7 4556.7 4564.0 4567.2 4606.1 4642.1 4738.0 4758.8 4877.4 4878.6 4946.4 5003.5 5024.2 5028.9 5079.8 4829.7 4834.9 4843.7 4865.0 4882.2 4788.0 4897.4 4899.7 5040.1 5076.6 5087.9 5187.0 5203.7 5204.4 5207.7 4898.7 4905.6 4912.7 4913.9 4941.2 4703.7 4762.9 4897.3 4909.2 4947.1 4705.5 4735.6 4797.7 4815.2 4844.3 4954.5 4995.6 4996.3 5034.7 5049.0 4659.6 4786.6 4895.0 4909.2 4910.7 15:22:02 INFO - 2015-11-19 15:22:02,747 DEBUG : BROWSER_OUTPUT: 15:22:02 INFO - 2015-11-19 15:22:02,747 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37951.91 Median:31795.94 stddev:57449.77 (180.7%) stddev-sans-first:57542.32 15:22:02 INFO - 2015-11-19 15:22:02,747 DEBUG : BROWSER_OUTPUT: Values: 556.2 566.7 573.4 578.5 586.1 26266.7 26849.3 35527.0 36552.0 36561.3 39973.8 40326.0 40468.2 40482.4 40542.0 6906.0 7837.4 8006.0 8006.5 8007.7 6977.3 7067.6 7069.5 7071.9 10021.4 10002.7 10097.7 10103.8 10108.7 10114.7 9793.3 9842.8 9878.7 9899.2 9908.4 7059.2 7241.5 10015.3 10317.9 10331.3 36451.0 36975.6 37027.6 37035.4 37102.6 2728.9 2774.2 2825.6 2838.5 2987.7 28298.6 28747.3 28781.4 28974.4 29136.4 3374.4 3468.1 3486.3 3547.6 3589.0 215335.8 216402.0 216541.0 216542.0 216830.0 55279.7 55741.7 55773.0 55774.4 55796.2 49318.0 50514.5 63931.4 65523.0 65695.7 11881.9 11905.6 11917.2 11978.9 11980.7 9772.6 9816.4 9817.8 9842.3 9861.8 18734.2 18943.0 19023.4 19045.0 19053.4 7335.1 7681.7 7766.2 7849.2 7856.1 807.6 892.1 920.1 958.9 1049.2 26953.7 27208.4 27245.5 27400.3 27504.9 951.3 958.0 972.3 996.4 1029.3 14126.9 14139.6 14237.9 14267.0 14376.9 266065.0 269905.0 270132.0 270148.0 271000.0 37916.1 47195.8 47479.0 47574.0 47638.3 1083.1 1108.2 1137.5 1151.7 1153.1 24169.2 24313.0 24792.8 24821.5 24851.5 35517.8 36556.0 36874.4 37559.4 42339.0 161320.2 161465.0 162402.0 162669.2 162738.0 26784.7 27065.1 27154.6 27176.5 27194.2 37035.6 38293.2 38425.6 39314.8 39319.0 29757.9 32883.3 33748.7 34012.8 34395.7 29896.3 30058.9 30230.4 32476.4 33895.8 30715.8 31026.2 31078.7 31115.5 33019.3 28439.0 28559.3 28851.3 28908.6 29233.9 22980.2 23018.9 23170.4 23318.5 23409.2 15:22:02 INFO - 2015-11-19 15:22:02,747 DEBUG : BROWSER_OUTPUT: 15:22:02 INFO - 2015-11-19 15:22:02,747 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26377.11 Median:22082.56 stddev:80557.33 (364.8%) stddev-sans-first:80759.60 15:22:02 INFO - 2015-11-19 15:22:02,749 DEBUG : BROWSER_OUTPUT: Values: 345.2 345.3 345.7 346.2 346.9 12543.4 12968.7 15305.3 15337.3 15796.4 11617.7 13761.7 14763.7 14965.4 14985.2 5057.2 5201.8 5209.4 5209.9 5210.2 3539.7 3630.5 5150.9 5193.2 5195.1 5631.2 5727.8 5767.7 5773.5 5778.3 5298.2 5304.0 5453.2 5725.2 5734.6 5088.0 5140.5 5169.9 5170.1 5170.9 18374.9 18556.5 18760.2 18763.5 18827.2 1681.6 1738.4 1858.4 1926.8 1956.2 12602.1 12677.2 12702.9 12798.3 12949.9 1680.6 1703.1 1709.4 1713.6 1746.9 51328.5 52966.5 53483.7 53568.0 53750.7 9390.3 9550.9 9650.8 9708.6 9782.6 12213.3 12253.6 12290.8 12300.9 12306.3 6752.2 6767.4 6769.5 6781.9 6825.6 6305.1 6311.3 6324.9 6365.0 6366.7 5707.1 5786.3 5790.0 5790.8 5916.2 1562.2 1637.8 1667.2 1668.3 1678.6 738.7 882.6 921.0 979.5 1019.0 15626.5 16586.8 16848.1 17177.9 17240.0 770.4 880.3 921.0 941.2 967.2 8421.2 8769.7 9195.5 9220.1 9332.0 482396.0 482902.0 495980.0 500449.0 507929.0 66763.0 68356.3 68387.0 68769.7 69368.7 1077.8 1080.4 1083.4 1101.4 1104.2 14327.4 14388.5 14590.3 14669.0 14682.0 31079.5 31616.5 31839.8 32036.8 32431.4 40534.6 40727.2 41538.6 41820.8 41876.4 8805.6 9146.2 9187.9 9211.8 9217.8 15710.4 15933.0 15983.8 16383.6 16412.8 12915.6 13552.8 13637.6 13726.1 13989.0 12710.4 13223.9 13283.5 13628.5 13658.5 13258.6 13285.7 13371.4 14099.1 14212.5 7106.6 8195.1 8658.8 8723.8 8747.1 8829.0 9936.0 13321.3 13505.0 13612.8 15:22:02 INFO - 2015-11-19 15:22:02,749 DEBUG : BROWSER_OUTPUT: 15:22:02 INFO - 2015-11-19 15:22:02,749 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4971.00 Median:6060.12 stddev:2577.77 (42.5%) stddev-sans-first:2569.57 15:22:02 INFO - 2015-11-19 15:22:02,749 DEBUG : BROWSER_OUTPUT: Values: 1218.1 1614.7 1658.4 1686.8 1695.5 5899.4 6727.1 6858.8 6867.1 6870.5 7035.5 7131.0 7145.4 7160.1 7161.5 1730.9 1765.9 2022.2 2064.0 2089.4 2083.4 2085.1 2089.6 2089.8 2090.4 2019.7 2053.4 2061.0 2065.5 2067.6 2021.1 2043.2 2062.2 2074.8 2077.7 2075.3 2076.5 2090.3 2098.9 2100.5 7025.1 7066.2 7085.9 7094.1 7107.9 4099.0 4188.7 4192.6 4198.4 4202.3 2315.2 2719.6 2845.8 2859.0 2868.6 830.8 834.8 883.9 884.0 952.5 9775.5 9791.7 9810.1 9813.9 9837.5 3929.5 3998.2 4002.5 4027.3 4041.1 7977.1 8014.4 8017.1 8025.8 8031.1 4222.0 4252.0 4259.3 4264.8 4267.2 3818.8 3855.1 3855.3 3856.1 3856.2 2976.3 3023.7 3251.6 3408.3 3408.7 1087.1 1112.0 1112.5 1116.6 1123.5 907.9 968.6 1150.8 1179.7 1181.6 6701.0 6720.7 6777.6 6779.2 6838.6 983.3 990.3 1013.3 1016.9 1016.9 5140.7 5184.3 5290.6 5324.6 5346.7 8466.3 8659.5 8741.0 8777.8 8782.9 8083.0 8263.7 8334.2 8639.1 8652.4 6781.5 6858.4 6873.5 6896.3 6923.6 6704.3 6769.3 6783.4 6820.7 6831.8 7622.6 7692.2 7794.4 7838.2 7846.5 7811.6 7874.2 7902.0 7975.3 8007.0 6442.7 6510.1 6510.3 6512.6 6535.2 5548.8 5685.0 5691.7 5696.3 6983.3 5677.0 6048.2 6539.8 6593.6 6600.8 6391.6 6397.5 6441.5 6488.5 6576.7 6557.5 6577.0 6578.1 6579.1 6595.7 5788.2 6019.1 6056.0 6062.3 6096.4 6003.8 6034.4 6038.9 6041.7 6057.9 15:22:02 INFO - 2015-11-19 15:22:02,749 DEBUG : BROWSER_OUTPUT: 15:22:02 INFO - 2015-11-19 15:22:02,749 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4706.37 Median:5291.25 stddev:1373.12 (26.0%) stddev-sans-first:1336.65 15:22:02 INFO - 2015-11-19 15:22:02,751 DEBUG : BROWSER_OUTPUT: Values: 305.7 308.6 312.5 318.5 320.6 5312.1 5417.5 5418.4 5439.4 5446.7 5306.2 5326.4 5327.3 5334.4 5341.8 3948.8 4046.9 4214.6 4220.7 4221.2 4079.0 4175.0 4190.8 4205.3 4208.0 4158.0 4160.4 4162.1 4164.0 4164.5 3906.7 4049.9 4052.1 4053.6 4168.3 3551.1 3556.2 3591.0 3685.3 3691.0 5150.5 5158.0 5161.5 5161.6 5164.4 4800.1 4811.7 4817.0 4819.4 4823.5 5506.6 5634.4 5645.7 5651.5 5654.8 4018.9 4021.6 4021.6 4023.8 4028.8 5914.9 5949.5 5954.5 5959.5 5960.9 4118.3 4154.3 4154.7 4159.1 4162.6 4118.2 4230.3 4249.5 4251.2 4276.6 4788.7 4790.3 4791.5 4795.6 4796.6 5670.8 5672.1 5674.3 5675.1 5679.3 1474.2 1501.8 1503.5 1506.6 1506.8 1030.6 1032.7 1035.7 1040.8 1061.2 4931.8 4954.1 4955.3 4960.6 4965.8 5848.6 5860.7 5861.9 5865.9 5866.9 4947.9 4953.8 4955.0 4958.1 4961.1 2925.9 2996.1 3111.7 3130.6 3167.3 5519.6 5600.1 5600.6 5604.6 5607.7 6064.4 6082.6 6084.6 6088.2 6091.8 5577.2 5583.7 5591.1 5591.4 5591.6 5778.2 5866.6 5892.0 5910.9 5916.4 5763.9 5773.3 5782.0 5782.3 5789.6 5578.0 5579.2 5581.7 5585.7 5587.3 4113.8 4190.5 4196.9 4197.7 4214.3 5897.0 5910.2 5912.1 5917.2 5924.0 5614.1 5614.6 5615.4 5618.6 5623.0 5608.8 5614.0 5621.5 5623.6 5627.1 5288.4 5534.9 5559.2 5576.0 5582.3 5670.9 5695.1 5699.3 5709.4 5715.4 5294.1 5420.6 5458.1 5541.5 5543.7 15:22:02 INFO - 2015-11-19 15:22:02,751 DEBUG : BROWSER_OUTPUT: 15:22:02 INFO - 2015-11-19 15:22:02,751 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12183.31 Median:43530.74 stddev:13764.28 (31.6%) stddev-sans-first:13776.10 15:22:02 INFO - 2015-11-19 15:22:02,751 DEBUG : BROWSER_OUTPUT: Values: 746.4 747.5 754.1 771.5 773.1 11052.6 11411.0 11756.8 11977.6 11981.6 12633.1 12900.0 12936.7 12955.0 13039.8 605.5 614.6 615.6 774.1 788.8 619.1 621.8 624.6 775.0 790.0 811.5 818.1 822.9 823.2 826.8 629.7 810.6 810.9 811.1 812.1 474.0 590.8 601.2 602.6 602.8 11510.3 11737.2 11758.4 11761.4 11806.4 10723.0 10881.5 10974.4 11263.0 11369.6 9415.7 9614.8 9809.3 9843.8 10128.4 3178.3 3193.2 3207.1 3273.1 3347.4 39856.0 39984.2 39996.4 40001.4 40071.4 9089.1 9249.9 9292.0 9398.4 9412.9 15666.8 15673.3 15682.2 15688.0 15691.8 6055.3 6087.0 6099.2 6386.9 6472.5 3494.3 3587.3 3600.7 3627.7 3667.4 2725.4 2750.3 2755.8 2758.7 2761.1 483.2 492.3 522.2 536.0 539.4 614.6 628.8 635.5 639.2 639.4 7396.3 7782.1 7922.0 8226.7 8653.5 474.5 516.1 594.0 595.6 633.3 3466.2 3511.5 3569.8 3630.4 3652.6 49037.5 49471.3 49552.5 49580.0 49614.0 41547.2 42099.0 43278.6 43319.1 43742.3 39249.2 40232.8 41073.0 41392.8 41418.8 7768.2 7802.0 8005.3 8037.0 8193.3 32631.3 33057.2 33452.0 33591.5 33705.5 36835.3 36974.3 41277.6 41810.0 42397.6 9928.2 9944.8 9951.9 9969.2 10165.7 10182.9 10665.7 11004.5 11063.7 11075.4 10047.6 10076.0 10440.3 10653.4 10730.6 10070.1 10275.0 10282.7 10518.8 10581.6 10002.4 10457.1 10496.2 10564.7 10599.2 8367.1 8367.8 8417.5 8447.3 8476.2 8510.3 8778.0 8943.2 8949.5 8996.2 15:22:02 INFO - 2015-11-19 15:22:02,751 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:22:02 INFO - 2015-11-19 15:22:02,751 DEBUG : BROWSER_OUTPUT: 15:22:03 INFO - 2015-11-19 15:22:03,530 INFO : Browser exited with error code: 0 15:22:03 INFO - 2015-11-19 15:22:03,553 INFO : Completed test dromaeo_css (00:18:39) 15:22:03 INFO - 2015-11-19 15:22:03,553 INFO : Starting test kraken 15:22:03 INFO - 2015-11-19 15:22:03,553 DEBUG : operating with platform_type : linux_ 15:22:03 INFO - 2015-11-19 15:22:03,553 INFO : Initialising browser for kraken test... 15:22:03 INFO - 2015-11-19 15:22:03,559 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi4jLCj/profile http://localhost:51981/getInfo.html 15:22:07 INFO - 2015-11-19 15:22:07,616 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:22:07 INFO - 2015-11-19 15:22:07,616 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:22:07 INFO - 2015-11-19 15:22:07,616 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:22:07 INFO - 2015-11-19 15:22:07,616 DEBUG : BROWSER_OUTPUT: __metrics 15:22:07 INFO - 2015-11-19 15:22:07,704 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:22:08 INFO - 2015-11-19 15:22:08,929 INFO : Browser initialized. 15:22:08 INFO - 2015-11-19 15:22:08,929 INFO : Running cycle 1/1 for kraken test... 15:22:08 INFO - 2015-11-19 15:22:08,930 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi4jLCj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:22:20 INFO - 2015-11-19 15:22:20,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 142123008 15:22:20 INFO - 2015-11-19 15:22:20,837 DEBUG : BROWSER_OUTPUT: 15:22:23 INFO - 2015-11-19 15:22:23,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51981/tests/kraken/driver.html?testName=audio-beat-detection) 15:22:24 INFO - 2015-11-19 15:22:24,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 174374912 15:22:24 INFO - 2015-11-19 15:22:24,015 DEBUG : BROWSER_OUTPUT: 15:22:26 INFO - 2015-11-19 15:22:26,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51981/tests/kraken/driver.html?testName=audio-dft) 15:22:27 INFO - 2015-11-19 15:22:27,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 164843520 15:22:27 INFO - 2015-11-19 15:22:27,347 DEBUG : BROWSER_OUTPUT: 15:22:30 INFO - 2015-11-19 15:22:30,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51981/tests/kraken/driver.html?testName=audio-fft) 15:22:30 INFO - 2015-11-19 15:22:30,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 152780800 15:22:30 INFO - 2015-11-19 15:22:30,920 DEBUG : BROWSER_OUTPUT: 15:22:32 INFO - 2015-11-19 15:22:32,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51981/tests/kraken/driver.html?testName=audio-oscillator) 15:22:33 INFO - 2015-11-19 15:22:33,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 155267072 15:22:33 INFO - 2015-11-19 15:22:33,543 DEBUG : BROWSER_OUTPUT: 15:22:35 INFO - 2015-11-19 15:22:35,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51981/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:22:36 INFO - 2015-11-19 15:22:36,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 157327360 15:22:36 INFO - 2015-11-19 15:22:36,333 DEBUG : BROWSER_OUTPUT: 15:22:39 INFO - 2015-11-19 15:22:39,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51981/tests/kraken/driver.html?testName=imaging-darkroom) 15:22:39 INFO - 2015-11-19 15:22:39,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 156823552 15:22:39 INFO - 2015-11-19 15:22:39,926 DEBUG : BROWSER_OUTPUT: 15:22:43 INFO - 2015-11-19 15:22:43,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51981/tests/kraken/driver.html?testName=imaging-desaturate) 15:22:43 INFO - 2015-11-19 15:22:43,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 156446720 15:22:43 INFO - 2015-11-19 15:22:43,907 DEBUG : BROWSER_OUTPUT: 15:22:46 INFO - 2015-11-19 15:22:46,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51981/tests/kraken/driver.html?testName=json-parse-financial) 15:22:47 INFO - 2015-11-19 15:22:47,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 157245440 15:22:47 INFO - 2015-11-19 15:22:47,305 DEBUG : BROWSER_OUTPUT: 15:22:49 INFO - 2015-11-19 15:22:49,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51981/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:22:49 INFO - 2015-11-19 15:22:49,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 161869824 15:22:49 INFO - 2015-11-19 15:22:49,661 DEBUG : BROWSER_OUTPUT: 15:22:51 INFO - 2015-11-19 15:22:51,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51981/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:22:52 INFO - 2015-11-19 15:22:52,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 162816000 15:22:52 INFO - 2015-11-19 15:22:52,136 DEBUG : BROWSER_OUTPUT: 15:22:54 INFO - 2015-11-19 15:22:54,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51981/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:22:54 INFO - 2015-11-19 15:22:54,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 170020864 15:22:54 INFO - 2015-11-19 15:22:54,850 DEBUG : BROWSER_OUTPUT: 15:22:57 INFO - 2015-11-19 15:22:57,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51981/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:22:57 INFO - 2015-11-19 15:22:57,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 177139712 15:22:57 INFO - 2015-11-19 15:22:57,949 DEBUG : BROWSER_OUTPUT: 15:23:00 INFO - 2015-11-19 15:23:00,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51981/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:23:01 INFO - 2015-11-19 15:23:01,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 174821376 15:23:01 INFO - 2015-11-19 15:23:01,077 DEBUG : BROWSER_OUTPUT: 15:23:02 INFO - 2015-11-19 15:23:02,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51981/tests/kraken/driver.html?testName=ai-astar) 15:23:03 INFO - 2015-11-19 15:23:03,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 234745856 15:23:03 INFO - 2015-11-19 15:23:03,059 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,061 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:23:03 INFO - 2015-11-19 15:23:03,061 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:23:03 INFO - 2015-11-19 15:23:03,061 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:23:03 INFO - 2015-11-19 15:23:03,061 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:23:03 INFO - 2015-11-19 15:23:03,061 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;105;111;113;113;103;111;103;111 15:23:03 INFO - 2015-11-19 15:23:03,062 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;138;157;172;132;175;154;132;173;130 15:23:03 INFO - 2015-11-19 15:23:03,062 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;161;160;161;160;162;162;162;162 15:23:03 INFO - 2015-11-19 15:23:03,062 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;78;92;72;72;72;98;93;74 15:23:03 INFO - 2015-11-19 15:23:03,062 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;92;127;92;92;92;129;91;92;132 15:23:03 INFO - 2015-11-19 15:23:03,062 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;110;109;109;110;109 15:23:03 INFO - 2015-11-19 15:23:03,062 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;146;148;147;148;146;146;146;147 15:23:03 INFO - 2015-11-19 15:23:03,062 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 15:23:03 INFO - 2015-11-19 15:23:03,062 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;71;70;70;71;70;70;79;68;68 15:23:03 INFO - 2015-11-19 15:23:03,063 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;69;70;69;69;69;69 15:23:03 INFO - 2015-11-19 15:23:03,063 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;85;83;83;92;83;84;89;83 15:23:03 INFO - 2015-11-19 15:23:03,063 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;120;127;129;129;124;126;124;121;127 15:23:03 INFO - 2015-11-19 15:23:03,063 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;145;145;149;148;133;145;151;145;134 15:23:03 INFO - 2015-11-19 15:23:03,063 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;67;67;69;71;70;69;69;69 15:23:03 INFO - 2015-11-19 15:23:03,063 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:23:03 INFO - 2015-11-19 15:23:03,064 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:23:03 INFO - 2015-11-19 15:23:03,064 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,984 15:23:03 INFO - 2015-11-19 15:23:03,064 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:23:03 INFO - 2015-11-19 15:23:03,064 DEBUG : BROWSER_OUTPUT: __startTimestamp1447975383060__endTimestamp 15:23:03 INFO - 2015-11-19 15:23:03,064 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.60 Median:111.50 stddev:4.25 (3.8%) stddev-sans-first:4.42 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 105.0 111.0 113.0 113.0 103.0 111.0 103.0 111.0 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.50 Median:155.50 stddev:17.88 (11.5%) stddev-sans-first:18.96 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: Values: 152.0 138.0 157.0 172.0 132.0 175.0 154.0 132.0 173.0 130.0 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 161.0 160.0 161.0 160.0 162.0 162.0 162.0 162.0 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,072 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:76.00 stddev:10.51 (13.8%) stddev-sans-first:10.79 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 78.0 92.0 72.0 72.0 72.0 98.0 93.0 74.0 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:92.00 stddev:18.02 (19.6%) stddev-sans-first:18.79 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: Values: 94.0 92.0 127.0 92.0 92.0 92.0 129.0 91.0 92.0 132.0 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 109.0 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 146.0 148.0 147.0 148.0 146.0 146.0 146.0 147.0 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,073 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.10 Median:70.50 stddev:3.25 (4.6%) stddev-sans-first:3.27 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: Values: 74.0 71.0 70.0 70.0 71.0 70.0 70.0 79.0 68.0 68.0 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 69.0 70.0 69.0 69.0 69.0 69.0 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:83.50 stddev:3.16 (3.8%) stddev-sans-first:3.28 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 85.0 83.0 83.0 92.0 83.0 84.0 89.0 83.0 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:126.50 stddev:3.06 (2.4%) stddev-sans-first:3.23 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: Values: 126.0 120.0 127.0 129.0 129.0 124.0 126.0 124.0 121.0 127.0 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:145.00 stddev:6.42 (4.4%) stddev-sans-first:6.27 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: Values: 136.0 145.0 145.0 149.0 148.0 133.0 145.0 151.0 145.0 134.0 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 15:23:03 INFO - 2015-11-19 15:23:03,074 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 67.0 67.0 69.0 71.0 70.0 69.0 69.0 69.0 15:23:03 INFO - 2015-11-19 15:23:03,075 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:23:03 INFO - 2015-11-19 15:23:03,075 DEBUG : BROWSER_OUTPUT: 15:23:03 INFO - 2015-11-19 15:23:03,949 INFO : Browser exited with error code: 0 15:23:03 INFO - 2015-11-19 15:23:03,997 INFO : Completed test kraken (00:01:00) 15:23:03 INFO - 2015-11-19 15:23:03,997 INFO : Starting test v8_7 15:23:03 INFO - 2015-11-19 15:23:03,997 DEBUG : operating with platform_type : linux_ 15:23:03 INFO - 2015-11-19 15:23:03,998 INFO : Initialising browser for v8_7 test... 15:23:04 INFO - 2015-11-19 15:23:04,004 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp80I4n1/profile http://localhost:51981/getInfo.html 15:23:07 INFO - 2015-11-19 15:23:07,977 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:23:07 INFO - 2015-11-19 15:23:07,977 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:23:07 INFO - 2015-11-19 15:23:07,977 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:23:07 INFO - 2015-11-19 15:23:07,977 DEBUG : BROWSER_OUTPUT: __metrics 15:23:08 INFO - 2015-11-19 15:23:08,138 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:23:09 INFO - 2015-11-19 15:23:09,373 INFO : Browser initialized. 15:23:09 INFO - 2015-11-19 15:23:09,373 INFO : Running cycle 1/1 for v8_7 test... 15:23:09 INFO - 2015-11-19 15:23:09,374 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp80I4n1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:23:21 INFO - 2015-11-19 15:23:21,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 141537280 15:23:21 INFO - 2015-11-19 15:23:21,302 DEBUG : BROWSER_OUTPUT: 15:23:42 INFO - 2015-11-19 15:23:42,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51981/tests/v8_7/run.html (next: http://localhost:51981/tests/v8_7/run.html) 15:23:43 INFO - 2015-11-19 15:23:43,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 434286592 15:23:43 INFO - 2015-11-19 15:23:43,027 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,027 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:23:43 INFO - 2015-11-19 15:23:43,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:23:43 INFO - 2015-11-19 15:23:43,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:23:43 INFO - 2015-11-19 15:23:43,027 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:23:43 INFO - 2015-11-19 15:23:43,027 DEBUG : BROWSER_OUTPUT: |0;Richards;163.15875346712352 15:23:43 INFO - 2015-11-19 15:23:43,028 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.93857965451056 15:23:43 INFO - 2015-11-19 15:23:43,028 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.1120448179272 15:23:43 INFO - 2015-11-19 15:23:43,028 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 15:23:43 INFO - 2015-11-19 15:23:43,028 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1976.2845849802372 15:23:43 INFO - 2015-11-19 15:23:43,028 DEBUG : BROWSER_OUTPUT: |5;Earley;794.912559618442 15:23:43 INFO - 2015-11-19 15:23:43,028 DEBUG : BROWSER_OUTPUT: |6;Boyer;12047.619047619048 15:23:43 INFO - 2015-11-19 15:23:43,028 DEBUG : BROWSER_OUTPUT: |7;RegExp;29285.714285714286 15:23:43 INFO - 2015-11-19 15:23:43,029 DEBUG : BROWSER_OUTPUT: |8;Splay;617.1393341553637 15:23:43 INFO - 2015-11-19 15:23:43,029 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 15:23:43 INFO - 2015-11-19 15:23:43,029 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:23:43 INFO - 2015-11-19 15:23:43,029 DEBUG : BROWSER_OUTPUT: __startTimestamp1447975423020__endTimestamp 15:23:43 INFO - 2015-11-19 15:23:43,029 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,029 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:23:43 INFO - 2015-11-19 15:23:43,029 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:23:43 INFO - 2015-11-19 15:23:43,029 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,030 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.16 Median:163.16 stddev:0.00 (0.0%) 15:23:43 INFO - 2015-11-19 15:23:43,030 DEBUG : BROWSER_OUTPUT: Values: 163.2 15:23:43 INFO - 2015-11-19 15:23:43,030 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,030 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.94 Median:191.94 stddev:0.00 (0.0%) 15:23:43 INFO - 2015-11-19 15:23:43,030 DEBUG : BROWSER_OUTPUT: Values: 191.9 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: Values: 280.1 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: Values: 5035.2 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: Values: 1976.3 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.91 Median:794.91 stddev:0.00 (0.0%) 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: Values: 794.9 15:23:43 INFO - 2015-11-19 15:23:43,031 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12047.62 Median:12047.62 stddev:0.00 (0.0%) 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: Values: 12047.6 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29285.71 Median:29285.71 stddev:0.00 (0.0%) 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: Values: 29285.7 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:617.14 Median:617.14 stddev:0.00 (0.0%) 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: Values: 617.1 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: Values: 4845.4 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:23:43 INFO - 2015-11-19 15:23:43,032 DEBUG : BROWSER_OUTPUT: 15:23:43 INFO - 2015-11-19 15:23:43,993 INFO : Browser exited with error code: 0 15:23:44 INFO - 2015-11-19 15:23:44,008 INFO : Completed test v8_7 (00:00:40) 15:23:44 INFO - 2015-11-19 15:23:44,472 INFO : Completed test suite (00:20:20) 15:23:44 INFO - 2015-11-19 15:23:44,472 DEBUG : Working with test: dromaeo_css 15:23:44 INFO - 2015-11-19 15:23:44,472 DEBUG : Generating results file: dromaeo_css 15:23:44 INFO - 2015-11-19 15:23:44,473 DEBUG : Working with test: kraken 15:23:44 INFO - 2015-11-19 15:23:44,474 DEBUG : Generating results file: kraken 15:23:44 INFO - 2015-11-19 15:23:44,474 INFO : javascript benchmark 15:23:44 INFO - 2015-11-19 15:23:44,474 DEBUG : Working with test: v8_7 15:23:44 INFO - 2015-11-19 15:23:44,474 DEBUG : Generating results file: v8_7 15:23:44 INFO - 2015-11-19 15:23:44,475 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:23:44 INFO - 2015-11-19 15:23:44,528 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 15:23:44 INFO - 2015-11-19 15:23:44,528 DEBUG : process_Request line: dromaeo_css 6321.49 graph.html#tests=[[72,131,35]] 15:23:44 INFO - 2015-11-19 15:23:44,528 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:23:44 INFO - 2015-11-19 15:23:44,559 DEBUG : process_Request line: kraken 1518.60 graph.html#tests=[[232,131,35]] 15:23:44 INFO - 2015-11-19 15:23:44,559 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:23:44 INFO - 2015-11-19 15:23:44,590 DEBUG : process_Request line: v8_7 19635.56 graph.html#tests=[[230,131,35]] 15:23:44 INFO - 2015-11-19 15:23:44,592 INFO : javascript benchmark 15:23:44 INFO - 2015-11-19 15:23:44,595 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2614.5163144818207, 2715.1854443666894, 2715.524783162946, 2726.1685186018267, 2739.561670132779, 4526.298423744317, 4651.372064771255, 4737.763111844407, 4772.451168115667, 4784.210605250134, 4662.743549104798, 4676.836310729125, 4701.106789709961, 4749.26386410107, 4780.211265141247, 4352.325389564622, 4356.520782713907, 4382.233109205892, 4401.383806267125, 4401.405810215628, 4458.97770511147, 4499.640028797705, 4507.301368287905, 4516.683832131752, 4531.886702832423, 4273.978630106845, 4333.328334108218, 4406.713563618355, 4408.845690400853, 4426.402435671175, 4378.78106094694, 4389.626881715058, 4396.494403143615, 4418.204723149832, 4420.535843736394, 4342.6742994275555, 4348.412964249817, 4356.463318459084, 4359.215341238576, 4389.012472193763, 4515.548445155491, 4516.706414083074, 4656.231721765905, 4665.510121437268, 4693.718376897397, 5128.025675121715, 5164.819231326923, 5194.324737784102, 5206.687598744087, 5210.817621383233, 5203.505666961671, 5218.0, 5222.451642577513, 5240.659357141812, 5285.127953887642, 4549.613282870993, 4670.0, 4677.345171675968, 4834.540718631724, 4836.322914791932, 5085.313482679865, 5167.6641018333685, 5174.353205849269, 5218.217267409843, 5230.529252367305, 4995.500449955048, 5001.64988450805, 5006.224035274538, 5046.62150338726, 5058.291839142523, 4881.975590122027, 4990.3762029746285, 4991.6006719463085, 5083.491650834961, 5103.897922041612, 5003.774830132653, 5054.0, 5059.620528460307, 5070.6957582545165, 5074.720890351066, 5077.720725360141, 5139.306193663808, 5139.9720055988955, 5142.280080788692, 5191.714455704972, 4075.38869169621, 4181.853635122817, 4185.22573323936, 4320.43834301545, 4334.848280310174, 3698.4267438547067, 3745.176061266517, 3763.2097259575794, 3778.131029863147, 3794.165283637595, 4400.537943515948, 4410.889727756768, 4411.18393097278, 4412.448443944507, 4450.532694067141, 4962.925556116661, 5106.157484015096, 5108.182690769459, 5156.071907056691, 5209.322788037531, 4269.146170765859, 4307.741535507879, 4315.741055536678, 4335.176316499855, 4353.82584696615, 4550.681452298308, 4556.658250631216, 4564.041551274203, 4567.1779079765965, 4606.124836281096, 4642.094791515622, 4737.976310118565, 4758.809647614056, 4877.3903262092235, 4878.634102442331, 4946.35697359341, 5003.474635163256, 5024.171011783015, 5028.949710502849, 5079.77141028662, 4829.710217386968, 4834.8791280218275, 4843.660943733905, 4864.951350486592, 4882.2432522959, 4787.952120478751, 4897.363342765418, 4899.706017638953, 5040.067587496325, 5076.593872490118, 5087.898242035212, 5187.0, 5203.713795741119, 5204.427512973494, 5207.661502002357, 4898.730569818694, 4905.637852303528, 4912.6561140719805, 4913.852584422473, 4941.234108713155, 4703.74129422885, 4762.904741905212, 4897.289892965571, 4909.214525675875, 4947.109520286383, 4705.5059218781535, 4735.573798358164, 4797.664163508521, 4815.2054910939305, 4844.297576851407, 4954.504549545017, 4995.575376093073, 4996.250562415521, 5034.723090230073, 5048.974755126348, 4659.603933665677, 4786.593139583175, 4895.0, 4909.1654418748185, 4910.656254062182], "unit": "ms", "name": "dojo.html", "value": 4659.669191822518}, {"lowerIsBetter": false, "replicates": [556.1851886985565, 566.6600039976014, 573.372157487551, 578.5342799046769, 586.1442294250394, 26266.737332626668, 26849.328766780814, 35526.99999999997, 36552.0, 36561.26877462449, 39973.800130999305, 40326.0, 40468.19063618726, 40482.39276410856, 40541.98645033876, 6905.965470172642, 7837.373010159188, 8005.959970200141, 8006.519608823489, 8007.719729809458, 6977.3022697730075, 7067.575945443265, 7069.540479868792, 7071.893921591154, 10021.44882031488, 10002.749931251741, 10097.747556311115, 10103.797924041515, 10108.747281317952, 10114.74713132174, 9793.314467987244, 9842.753931151707, 9878.703638890809, 9899.208063354914, 9908.355956862853, 7059.2234854166, 7241.5293005954445, 10015.298929074968, 10317.9484102579, 10331.27681062326, 36451.0, 36975.63024369749, 37027.62972370296, 37035.44446833299, 37102.62897371019, 2728.890844366223, 2774.1677496750895, 2825.6185414969127, 2838.4606924684244, 2987.656419511762, 28298.575521367195, 28747.28131796701, 28781.42437151266, 28974.420511589862, 29136.41727165466, 3374.416656694998, 3468.1329667583104, 3486.267883744417, 3547.592026916912, 3589.0, 215335.76996345067, 216402.0, 216541.0, 216542.0, 216830.0, 55279.72360138254, 55741.72129139328, 55773.0, 55774.442255577735, 55796.16305755417, 49318.0, 50514.49485505098, 63931.36068639347, 65523.0, 65695.67152164305, 11881.881181188077, 11905.642830715093, 11917.22538035025, 11978.92189702931, 11980.700482487833, 9772.560234789451, 9816.411015339103, 9817.803643927224, 9842.261830362751, 9861.753456163653, 18734.156962936428, 18943.0, 19023.429297121107, 19045.0, 19053.42839714811, 7335.1197856257595, 7681.731139410093, 7766.184550622103, 7849.215078492105, 7856.09654889695, 807.6083099696642, 892.1034360467818, 920.130476699526, 958.8513780364054, 1049.1921220660201, 26953.730462695516, 27208.425886640194, 27245.455090898467, 27400.314992124957, 27504.862475687893, 951.2770294576172, 957.9856302155473, 972.2999440402899, 996.3872218585518, 1029.3360782295379, 14126.939745561327, 14139.64650883736, 14237.857621423653, 14267.0, 14376.856231437761, 266065.0, 269905.0, 270132.0, 270148.0, 271000.0, 37916.052098697204, 47195.764021179675, 47479.0, 47574.0, 47638.28542571864, 1083.1443159903745, 1108.174410064491, 1137.4710759496709, 1151.694800877768, 1153.0890596428728, 24169.154079607128, 24313.0, 24792.752072479045, 24821.50356992886, 24851.502969940862, 35517.82241088778, 36556.0, 36874.44688329624, 37559.43660845144, 42339.0, 161320.19339903226, 161465.0, 162402.0, 162669.18665406597, 162738.0, 26784.732152678225, 27065.052723154597, 27154.592681109403, 27176.456470870868, 27194.184174474798, 37035.6296437043, 38293.23413531658, 38425.6157438422, 39314.80342598269, 39319.0, 29757.851210743807, 32883.34233315368, 33748.66251337554, 34012.82993585016, 34395.656043439245, 29896.25259368533, 30058.947936822107, 30230.395392092476, 32476.350472989936, 33895.83052084724, 30715.846420767753, 31026.224344391572, 31078.68921310758, 31115.533267001465, 33019.33961320808, 28439.0, 28559.28601784972, 28851.278718032216, 28908.566371504025, 29233.85383073071, 22980.19569315066, 23018.884905575364, 23170.420739481648, 23318.53362932698, 23409.180678676166], "unit": "ms", "name": "ext.html", "value": 16600.594690599828}, {"lowerIsBetter": false, "replicates": [345.2387485594264, 345.29731995389386, 345.6992416597559, 346.2469129643024, 346.91500582357327, 12543.435545400456, 12968.675783105404, 15305.311260993254, 15337.309821058052, 15796.368145274204, 11617.65147045588, 13761.65595860104, 14763.704725905476, 14965.401383944656, 14985.175815330153, 5057.241413787933, 5201.765920533585, 5209.426963034063, 5209.921851172236, 5210.192420174879, 3539.681428671419, 3630.52803135592, 5150.896982060356, 5193.16909294513, 5195.142801437777, 5631.155326700987, 5727.770889164429, 5767.740451679684, 5773.538116950634, 5778.3066032076, 5298.205269209611, 5304.045271851065, 5453.182022696587, 5725.198472213893, 5734.569907256951, 5088.0, 5140.460251673558, 5169.870753231199, 5170.1469257572835, 5170.896582068375, 18374.908125459286, 18556.536086597942, 18760.24959001638, 18763.53091172718, 18827.24691012358, 1681.6216351320977, 1738.3915629529563, 1858.3681548273653, 1926.807319268062, 1956.2272902203692, 12602.117851750381, 12677.17598356104, 12702.872971270353, 12798.296093714842, 12949.935250323782, 1680.5889988802708, 1703.1484257871064, 1709.4102534625533, 1713.6230029393514, 1746.8515176210037, 51328.48671513312, 52966.47033529654, 53483.732581336844, 53568.0, 53750.73124634391, 9390.295727820305, 9550.856737148948, 9650.758731031781, 9708.563114659857, 9782.608695652236, 12213.267203967791, 12253.571125010581, 12290.754184916252, 12300.938495307646, 12306.323152226534, 6752.189737231563, 6767.424768894699, 6769.492288078413, 6781.864362712817, 6825.590464572141, 6305.14880491137, 6311.27420346666, 6324.9051264231075, 6364.968175159094, 6366.745330186834, 5707.086866101404, 5786.334571524329, 5789.964261326023, 5790.797322093791, 5916.2013128228, 1562.2110834028742, 1637.8116516600505, 1667.1747484995005, 1668.3410053028986, 1678.5551828765388, 738.7229788829189, 882.5543100734088, 920.9777147366418, 979.4661909259471, 1018.9745256368502, 15626.453074142577, 16586.75119873203, 16848.14721026428, 17177.914110429618, 17240.0, 770.4183341577074, 880.3397451911067, 921.0381886581672, 941.2187884056217, 967.2358836519212, 8421.242088211968, 8769.736907892773, 9195.540222988824, 9220.124088211609, 9332.040271542915, 482396.0, 482902.0, 495980.0, 500449.0, 507929.0, 66763.0, 68356.31643683599, 68387.0, 68769.65615171893, 69368.6531567339, 1077.7682798198425, 1080.37338343762, 1083.4257843343041, 1101.372217835826, 1104.2270410712533, 14327.355269013127, 14388.467707389296, 14590.270486475845, 14669.0, 14682.0, 31079.533806993364, 31616.525752114198, 31839.840800795846, 32036.839815800773, 32431.351372971938, 40534.59465405308, 40727.1854562913, 41538.58461415347, 41820.79089604533, 41876.371854421595, 8805.647774088964, 9146.176844084064, 9187.908120918706, 9211.815763684555, 9217.815643687223, 15710.371585136467, 15933.0, 15983.760243596123, 16383.590410239363, 16412.753808693116, 12915.612531624067, 13552.796708049584, 13637.590872273848, 13726.107802992774, 13989.0, 12710.36448177606, 13223.933880330536, 13283.535076272285, 13628.523001694894, 13658.453661853811, 13258.602241932758, 13285.734285314433, 13371.39828707691, 14099.083559568595, 14212.502562410265, 7106.609136497542, 8195.098539160568, 8658.78353041179, 8723.781905452415, 8747.125287471203, 8829.0, 9936.0, 13321.267330296927, 13505.0, 13612.8429083529], "unit": "ms", "name": "jquery.html", "value": 8355.61066886003}, {"lowerIsBetter": false, "replicates": [1218.116865272678, 1614.6770645870824, 1658.3532422355283, 1686.7891513560805, 1695.5337282247376, 5899.4395532424405, 6727.091842601248, 6858.828529286758, 6867.141607299088, 6870.519063665545, 7035.542689725165, 7131.0, 7145.356917877403, 7160.069191005175, 7161.462890283224, 1730.9134543272849, 1765.9381921632746, 2022.2113375783383, 2063.989680051601, 2089.4045197118826, 2083.364573804989, 2085.1242478159133, 2089.60297543467, 2089.8328133749264, 2090.3519908828234, 2019.6768517037276, 2053.4147767886157, 2060.979390206101, 2065.524929266262, 2067.648499755045, 2021.080408414168, 2043.213362855304, 2062.247279742898, 2074.834013278934, 2077.66757318829, 2075.30477290108, 2076.512019675375, 2090.310197634777, 2098.8635738676935, 2100.537881666031, 7025.051618031552, 7066.2227155013425, 7085.89371159433, 7094.11323584552, 7107.92892071083, 4098.979505102485, 4188.748675079505, 4192.559781222958, 4198.3702444633545, 4202.327627579603, 2315.247544548012, 2719.551274039781, 2845.8434786086755, 2858.957115643267, 2868.641419822522, 830.7549272964429, 834.7787836223406, 883.9116088391173, 883.9823203535893, 952.4666186935339, 9775.51122443875, 9791.706248812547, 9810.068043535925, 9813.901860981441, 9837.458939758382, 3929.5088113985753, 3998.1803730235233, 4002.459667944848, 4027.335489644176, 4041.131156801302, 7977.122516523178, 8014.438989270695, 8017.118117007125, 8025.7993550160545, 8031.076426210943, 4222.0289333453475, 4252.043290259667, 4259.254630439661, 4264.829406823755, 4267.1892340455215, 3818.8281527331337, 3855.0747820523434, 3855.267499175148, 3856.1130939883983, 3856.1709232515145, 2976.345204055104, 3023.7429818465675, 3251.5935508061493, 3408.2672225471642, 3408.7102596279096, 1087.1302957633861, 1112.0158659586325, 1112.5327362507767, 1116.5757012335262, 1123.4775829239443, 907.8955920069144, 968.6077138758814, 1150.8446359741495, 1179.7463545337794, 1181.5746331320718, 6701.0, 6720.731170753115, 6777.6272305023695, 6779.220389655155, 6838.555493892881, 983.2969426859829, 990.2770977186694, 1013.2755080117752, 1016.8779746430328, 1016.9186465082776, 5140.742962851842, 5184.326037615161, 5290.603204759658, 5324.627276090714, 5346.652467589672, 8466.280366168821, 8659.523726194993, 8740.956295218482, 8777.780555486164, 8782.912170878337, 8082.959585202037, 8263.669453221804, 8334.20825021622, 8639.092895246034, 8652.3510736695, 6781.4574834013165, 6858.417034552019, 6873.48448866337, 6896.27589103147, 6923.6192009438955, 6704.262531121671, 6769.255381908085, 6783.423409010092, 6820.727170913108, 6831.760888368884, 7622.580758058139, 7692.230776922263, 7794.376449883882, 7838.216178382344, 7846.5292082475235, 7811.648475818715, 7874.212578742309, 7901.961564476927, 7975.282224599814, 8007.0, 6442.710078046405, 6510.088587597835, 6510.251321098134, 6512.6092434454085, 6535.215774107138, 5548.778048878161, 5684.971575142098, 5691.658500489983, 5696.344920334049, 6983.301669832976, 5677.0, 6048.213732214784, 6539.771108011197, 6593.571417857824, 6600.834979125369, 6391.616503009835, 6397.456216221487, 6441.5490915635455, 6488.513361497812, 6576.736930522726, 6557.475401967736, 6577.046328282468, 6578.144841170617, 6579.111819904251, 6595.703193356215, 5788.189653448437, 6019.127226552213, 6055.969720151371, 6062.333143354139, 6096.359882212481, 6003.7898673546215, 6034.366391528826, 6038.909416358671, 6041.697915104315, 6057.909131362945], "unit": "ms", "name": "mootools.html", "value": 4087.7509512777774}, {"lowerIsBetter": false, "replicates": [305.7080488133832, 308.63889249577994, 312.4844007387811, 318.5269874236757, 320.5720363314974, 5312.096943519601, 5417.539509141728, 5418.376886658036, 5439.374471935728, 5446.700431476267, 5306.230596563496, 5326.414094449608, 5327.2808170896915, 5334.359876814778, 5341.786328546863, 3948.802559872009, 4046.8988275293204, 4214.599613036772, 4220.746755194683, 4221.155768846228, 4078.9592104078874, 4174.97912510437, 4190.811413486401, 4205.306124489455, 4208.032152604903, 4158.043649960511, 4160.375943608453, 4162.063535704473, 4163.979180104096, 4164.500259968793, 3906.7069969752242, 4049.898752531181, 4052.0680243543857, 4053.5946405359227, 4168.291390463629, 3551.147724546116, 3556.199855032623, 3590.964090359089, 3685.3182161300247, 3691.003429074135, 5150.510701483353, 5157.974210128926, 5161.535461808456, 5161.5870730341485, 5164.406093299281, 4800.063987522434, 4811.711297322172, 4817.0365926814775, 4819.397575303087, 4823.5176482351835, 5506.559475241971, 5634.408387119334, 5645.717714114319, 5651.491365777099, 5654.802081927154, 4018.8995275118064, 4021.597840215955, 4021.5978402159844, 4023.7988100594853, 4028.8187031583357, 5914.852128696774, 5949.524038076944, 5954.46409823118, 5959.523238140939, 5960.9105863412515, 4118.341065429517, 4154.335306350969, 4154.729942553724, 4159.064210552601, 4162.604552567501, 4118.238125946709, 4230.280852255124, 4249.46881639795, 4251.213525497793, 4276.57234276576, 4788.7366194859615, 4790.281457781361, 4791.520847915251, 4795.6163506919365, 4796.592289655348, 5670.829875103754, 5672.064109421899, 5674.347450043216, 5675.120356344773, 5679.346875109415, 1474.2039298778539, 1501.7822415749656, 1503.4512402973055, 1506.615812967708, 1506.8417816129368, 1030.6289735695143, 1032.6592224565875, 1035.7255327338262, 1040.7970445763156, 1061.1775873697945, 4931.802727890844, 4954.133026720309, 4955.281484184845, 4960.627952903475, 4965.776540055706, 5848.590598658053, 5860.677662728591, 5861.88276234473, 5865.882682346414, 5866.882662346815, 4947.90104197914, 4953.826616068421, 4954.950450495521, 4958.057968985881, 4961.05739909416, 2925.8537073146686, 2996.10116964914, 3111.68883111687, 3130.624325081005, 3167.255694911694, 5519.558435325164, 5600.131979543177, 5600.551955843523, 5604.635698679573, 5607.663540187602, 6064.393560643988, 6082.635041897412, 6084.574079814371, 6088.178095957078, 6091.786787462417, 5577.191307260425, 5583.69289689071, 5591.10542313228, 5591.3569939456665, 5591.608587398843, 5778.16216648592, 5866.6480011199465, 5892.0, 5910.911336330045, 5916.378780228014, 5763.884722305446, 5773.336066352424, 5782.045962416154, 5782.306123265235, 5789.56578256624, 5578.0, 5579.218909352775, 5581.665100094007, 5585.748641311069, 5587.329520457572, 4113.794310284534, 4190.497140343056, 4196.9370459442525, 4197.664186865105, 4214.346776249687, 5897.026990546512, 5910.231669882888, 5912.142739302863, 5917.201177840936, 5924.0, 5614.07367784311, 5614.63504872182, 5615.438456154352, 5618.550515958796, 5623.044082506066, 5608.803691870765, 5614.04561224601, 5621.494065534122, 5623.606347555632, 5627.0715331971405, 5288.3918349390315, 5534.861628459321, 5559.16612508127, 5575.972120139373, 5582.27430434041, 5670.858228544319, 5695.145728140812, 5699.349802341765, 5709.429057094258, 5715.428457154251, 5294.100002999422, 5420.647657902224, 5458.1266997280245, 5541.473560011793, 5543.722813859372], "unit": "ms", "name": "prototype.html", "value": 4270.745542466444}, {"lowerIsBetter": false, "replicates": [746.4364404874319, 747.4991755523798, 754.1101500229728, 771.4522688890887, 773.0684525147195, 11052.557897684093, 11411.0, 11756.823647645293, 11977.64067077989, 11981.640550783468, 12633.052521060912, 12900.0, 12936.741265174714, 12955.0, 13039.804402933964, 605.5125623872781, 614.5575185866169, 615.5567991046439, 774.0749803984241, 788.8304014636852, 619.1023016625888, 621.8196722950339, 624.5596854217788, 775.042822114688, 789.9802504937365, 811.4603788480654, 818.0796603820702, 822.880682301066, 823.2426167925523, 826.8139668574582, 629.7418058595954, 810.6392655268407, 810.8580998325328, 811.1158836867813, 812.1229072601576, 473.9976300118512, 590.7755053079845, 601.1974014690394, 602.5510994309224, 602.7769725201659, 11510.30938143714, 11737.178397512092, 11758.412079395996, 11761.41192940358, 11806.350650714206, 10722.981316774894, 10881.510332035077, 10974.396408197546, 11263.0, 11369.602063927723, 9415.670451534163, 9614.807703845954, 9809.313348065638, 9843.803123937552, 10128.442935638537, 3178.284885900677, 3193.1538142392283, 3207.06994971458, 3273.116258610186, 3347.397468455677, 39856.0, 39984.20031599381, 39996.40005399892, 40001.399979000336, 40071.39892901609, 9089.136532029446, 9249.861252081224, 9291.953540232256, 9398.436093834393, 9412.858807117898, 15666.764998525032, 15673.294701738449, 15682.215889205494, 15688.0, 15691.843081569266, 6055.273367195965, 6086.969565152234, 6099.207103076572, 6386.904196437057, 6472.546921715435, 3494.2836718472654, 3587.264610754789, 3600.6759391654355, 3627.6553727395853, 3667.4132138857653, 2725.3731641722516, 2750.2849259192353, 2755.8484283364205, 2758.655168103987, 2761.0750398616287, 483.24131114151146, 492.3058487532562, 522.193211488244, 536.0431629541328, 539.3527766679921, 614.5698011392044, 628.7767842415968, 635.5424094651843, 639.2009987515605, 639.3702203329716, 7396.260373962561, 7782.143964163937, 7922.049354077548, 8226.670933162726, 8653.480791152551, 474.49703314486754, 516.1406258579498, 593.9673317967466, 595.6426144313377, 633.3002032753833, 3466.168119651316, 3511.455724362728, 3569.821508924543, 3630.3828349180703, 3652.6164752701116, 49037.509624903294, 49471.28965327615, 49552.50447495551, 49580.0, 49614.0, 41547.169056618695, 42099.0, 43278.56721432808, 43319.133617327476, 43742.343864842056, 39249.21501569953, 40232.79883600563, 41072.9999999994, 41392.79303603523, 41418.792906035276, 7768.184340644377, 7801.9609901950125, 8005.319547838499, 8037.035555733116, 8193.303569196685, 32631.347373051933, 33057.173570660925, 33452.0, 33591.496127558596, 33705.49441758425, 36835.26329473449, 36974.26051478901, 41277.587224127376, 41810.0, 42397.576024239366, 9928.205743540355, 9944.751381215527, 9951.850722239316, 9969.152622027208, 10165.745856353651, 10182.949085254822, 10665.733356666145, 11004.504797284302, 11063.668089957315, 11075.390853502813, 10047.648332308334, 10076.0, 10440.269181157246, 10653.360798352123, 10730.62442814529, 10070.093691567794, 10275.0, 10282.742931426774, 10518.789624207626, 10581.576736930436, 10002.399856008662, 10457.111145552713, 10496.212784041074, 10564.735881603021, 10599.205059620404, 8367.07962124178, 8367.832643347221, 8417.537035463109, 8447.324214062983, 8476.194761497647, 8510.276626486819, 8777.956110219407, 8943.23982461472, 8949.463032218087, 8996.235319997873], "unit": "ms", "name": "yui.html", "value": 5654.931015050988}], "name": "dromaeo_css", "value": 6321.48874905057}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 105.0, 111.0, 113.0, 113.0, 103.0, 111.0, 103.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [152.0, 138.0, 157.0, 172.0, 132.0, 175.0, 154.0, 132.0, 173.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 160.0, 161.0, 160.0, 162.0, 162.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 78.0, 92.0, 72.0, 72.0, 72.0, 98.0, 93.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 127.0, 92.0, 92.0, 92.0, 129.0, 91.0, 92.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 103.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 146.0, 148.0, 147.0, 148.0, 146.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 70.0, 70.0, 71.0, 70.0, 70.0, 79.0, 68.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 85.0, 83.0, 83.0, 92.0, 83.0, 84.0, 89.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [126.0, 120.0, 127.0, 129.0, 129.0, 124.0, 126.0, 124.0, 121.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [136.0, 145.0, 145.0, 149.0, 148.0, 133.0, 145.0, 151.0, 145.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 67.0, 69.0, 71.0, 70.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1518.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.15875346712352], "unit": "score", "name": "Richards", "value": 216.36595800000006}, {"lowerIsBetter": false, "replicates": [191.93857965451056], "unit": "score", "name": "DeltaBlue", "value": 344.4747799999999}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [794.912559618442], "unit": "score", "name": "Earley", "value": 838.4104539999996}, {"lowerIsBetter": false, "replicates": [12047.619047619048], "unit": "score", "name": "Boyer", "value": 55.31906324110671}, {"lowerIsBetter": false, "replicates": [29285.714285714286], "unit": "score", "name": "RegExp", "value": 31.10680487804877}, {"lowerIsBetter": false, "replicates": [617.1393341553637], "unit": "score", "name": "Splay", "value": 132.04635564435563}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19635.556920481165}]} 15:23:44 INFO - RETURN: dromaeo_css: 6321.49 15:23:44 INFO - RETURN: kraken: 1518.60 15:23:44 INFO - RETURN: v8_7: 19635.56 15:23:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19635.56"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1518.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "6321.49"}}} 15:23:44 INFO - Return code: 0 15:23:44 INFO - # TBPL SUCCESS # 15:23:44 INFO - Running post-action listener: _resource_record_post_action 15:23:44 INFO - Running post-run listener: _resource_record_post_run 15:23:45 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 65536; Write bytes: 515641344; Read time: 68; Write time: 635524 15:23:45 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 171540480; Read time: 0; Write time: 342964 15:23:45 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 65536; Write bytes: 339431424; Read time: 68; Write time: 292304 15:23:45 INFO - Running post-run listener: _upload_blobber_files 15:23:45 INFO - Blob upload gear active. 15:23:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:23:45 INFO - Copying logs to upload dir... 15:23:45 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.006578 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-19 15:23:45.788774) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 15:23:45.792480) ========= 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=7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009870 build_url: 'https://queue.taskcluster.net/v1/task/pfWpdhPbTNuNODLLncV4Hg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 15:23:45.843965) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:23:45.844297) ========= 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=7d909545e45784438f4e8e36000001b3-1447974141.797857-735428021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 15:23:45.893992) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 15:23:45.894307) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 15:23:45.894591) ========= ========= Total master_lag: 1.07 =========