builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1448368413.65 results: success (0) buildid: 20151124035431 builduid: 4dc1bdbdf06e417a8c5607ce424380e0 revision: 5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:33.655209) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:33.655801) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:33.656084) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.002967 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:33.691452) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:33.691769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:33.716712) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:33.717105) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018472 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:33.766802) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:33.767177) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:33.767588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:33.767882) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 04:33:33-- 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% 228M=0s 2015-11-24 04:33:33 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.244439 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:34.024511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:34.024821) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.154500 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:34.189218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:34.189614) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea --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=d60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 04:33:34,125 truncating revision to first 12 chars 2015-11-24 04:33:34,125 Setting DEBUG logging. 2015-11-24 04:33:34,126 attempt 1/10 2015-11-24 04:33:34,126 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/5a6b4eae6d8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 04:33:34,775 unpacking tar archive at: b2g-inbound-5a6b4eae6d8e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.942618 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:35.146524) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:35.146899) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:35.405079) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:35.405504) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 04:33:35.405975) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-24 04:33:35.406257) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:33:35 INFO - MultiFileLogger online at 20151124 04:33:35 in /builds/slave/test 04:33:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 04:33:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:33:35 INFO - {'append_to_log': False, 04:33:35 INFO - 'base_work_dir': '/builds/slave/test', 04:33:35 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 04:33:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:33:35 INFO - 'branch': 'B2G-Inbound-Non-PGO', 04:33:35 INFO - 'buildbot_json_path': 'buildprops.json', 04:33:35 INFO - 'config_files': ('talos/linux_config.py',), 04:33:35 INFO - 'default_actions': ('clobber', 04:33:35 INFO - 'read-buildbot-config', 04:33:35 INFO - 'download-and-extract', 04:33:35 INFO - 'populate-webroot', 04:33:35 INFO - 'create-virtualenv', 04:33:35 INFO - 'install', 04:33:35 INFO - 'run-tests'), 04:33:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:33:35 INFO - 'download_minidump_stackwalk': True, 04:33:35 INFO - 'download_symbols': 'ondemand', 04:33:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:33:35 INFO - 'tooltool.py': '/tools/tooltool.py', 04:33:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:33:35 INFO - '/tools/misc-python/virtualenv.py')}, 04:33:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:33:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:33:35 INFO - 'installer_path': 'installer.exe', 04:33:35 INFO - 'log_level': 'info', 04:33:35 INFO - 'log_name': 'talos', 04:33:35 INFO - 'log_to_console': True, 04:33:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:33:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:33:35 INFO - 'opt_config_files': (), 04:33:35 INFO - 'pip_index': False, 04:33:35 INFO - 'sps_profile': False, 04:33:35 INFO - 'sps_profile_interval': 0, 04:33:35 INFO - 'suite': 'dromaeojs', 04:33:35 INFO - 'system_bits': '64', 04:33:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:33:35 INFO - 'title': 'talos-linux64-ix-019', 04:33:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:33:35 INFO - 'use_talos_json': True, 04:33:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:33:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:33:35 INFO - 'work_dir': 'build'} 04:33:35 INFO - ##### 04:33:35 INFO - ##### Running clobber step. 04:33:35 INFO - ##### 04:33:35 INFO - Running pre-action listener: _resource_record_pre_action 04:33:35 INFO - Running main action method: clobber 04:33:35 INFO - rmtree: /builds/slave/test/build 04:33:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:33:38 INFO - Running post-action listener: _resource_record_post_action 04:33:38 INFO - ##### 04:33:38 INFO - ##### Running read-buildbot-config step. 04:33:38 INFO - ##### 04:33:38 INFO - Running pre-action listener: _resource_record_pre_action 04:33:38 INFO - Running main action method: read_buildbot_config 04:33:38 INFO - Using buildbot properties: 04:33:38 INFO - { 04:33:38 INFO - "properties": { 04:33:38 INFO - "buildnumber": 284, 04:33:38 INFO - "product": "firefox", 04:33:38 INFO - "script_repo_revision": "production", 04:33:38 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:33:38 INFO - "repository": "", 04:33:38 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 04:33:38 INFO - "buildid": "20151124035431", 04:33:38 INFO - "slavename": "talos-linux64-ix-019", 04:33:38 INFO - "pgo_build": "False", 04:33:38 INFO - "basedir": "/builds/slave/test", 04:33:38 INFO - "project": "", 04:33:38 INFO - "platform": "ubuntu64_hw", 04:33:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:33:38 INFO - "slavebuilddir": "test", 04:33:38 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 04:33:38 INFO - "branch": "b2g-inbound", 04:33:38 INFO - "repo_path": "integration/b2g-inbound", 04:33:38 INFO - "stage_platform": "linux64", 04:33:38 INFO - "builduid": "4dc1bdbdf06e417a8c5607ce424380e0", 04:33:38 INFO - "revision": "5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea" 04:33:38 INFO - }, 04:33:38 INFO - "sourcestamp": { 04:33:38 INFO - "repository": "", 04:33:38 INFO - "hasPatch": false, 04:33:38 INFO - "project": "", 04:33:38 INFO - "branch": "b2g-inbound-linux64-talos", 04:33:38 INFO - "changes": [ 04:33:38 INFO - { 04:33:38 INFO - "category": null, 04:33:38 INFO - "files": [ 04:33:38 INFO - { 04:33:38 INFO - "url": null, 04:33:38 INFO - "name": "https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:33:38 INFO - } 04:33:38 INFO - ], 04:33:38 INFO - "repository": "", 04:33:38 INFO - "rev": "5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea", 04:33:38 INFO - "who": "nigelbabu@gmail.com", 04:33:38 INFO - "when": 1448368402, 04:33:38 INFO - "number": 6699934, 04:33:38 INFO - "comments": "Backed out changeset c9cfbe159b26 (bug 1200133) for failing it's own tests", 04:33:38 INFO - "project": "", 04:33:38 INFO - "at": "Tue 24 Nov 2015 04:33:22", 04:33:38 INFO - "branch": "b2g-inbound-linux64-talos", 04:33:38 INFO - "revlink": "", 04:33:38 INFO - "properties": [ 04:33:38 INFO - [ 04:33:38 INFO - "buildid", 04:33:38 INFO - "20151124035431", 04:33:38 INFO - "Change" 04:33:38 INFO - ], 04:33:38 INFO - [ 04:33:38 INFO - "builduid", 04:33:38 INFO - "4dc1bdbdf06e417a8c5607ce424380e0", 04:33:38 INFO - "Change" 04:33:38 INFO - ], 04:33:38 INFO - [ 04:33:38 INFO - "pgo_build", 04:33:38 INFO - "False", 04:33:38 INFO - "Change" 04:33:38 INFO - ] 04:33:38 INFO - ], 04:33:38 INFO - "revision": "5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea" 04:33:38 INFO - } 04:33:38 INFO - ], 04:33:38 INFO - "revision": "5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea" 04:33:38 INFO - } 04:33:38 INFO - } 04:33:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:33:38 INFO - Running post-action listener: _resource_record_post_action 04:33:38 INFO - ##### 04:33:38 INFO - ##### Running download-and-extract step. 04:33:38 INFO - ##### 04:33:38 INFO - Running pre-action listener: _resource_record_pre_action 04:33:38 INFO - Running main action method: download_and_extract 04:33:38 INFO - mkdir: /builds/slave/test/build/tests 04:33: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')]} 04:33:38 INFO - https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:33:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/test_packages.json 04:33:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/test_packages.json 04:33:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:33:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:33:40 INFO - Downloaded 1302 bytes. 04:33:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:33:40 INFO - Using the following test package requirements: 04:33:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:33:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:33:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'jsshell-linux-x86_64.zip'], 04:33:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:33:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:33:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:33:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:33:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:33:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:33:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:33:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:40 INFO - https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:33:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:33:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:33:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/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 04:33:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/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 04:33:41 INFO - Downloaded 21341474 bytes. 04:33:41 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 04:33:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:33:41 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 04:33:42 INFO - Return code: 0 04:33:42 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 04:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:42 INFO - https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:33:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:33:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:33:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/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 04:33:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/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 04:33:44 INFO - Downloaded 21341474 bytes. 04:33:44 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 04:33:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:33:44 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 04:33:46 INFO - Return code: 0 04:33: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')]} 04:33:46 INFO - https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:33:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:33:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:33:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/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 04:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/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 04:33:47 INFO - Downloaded 11130997 bytes. 04:33:47 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 04:33:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:33:47 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 04:33:48 INFO - Return code: 0 04:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:48 INFO - https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:33:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:33:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:33:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/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 04:33:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/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 04:33:49 INFO - Downloaded 56026593 bytes. 04:33:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:33:49 INFO - mkdir: /builds/slave/test/properties 04:33:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:33:49 INFO - Writing to file /builds/slave/test/properties/build_url 04:33:49 INFO - Contents: 04:33:49 INFO - build_url:https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:33:49 INFO - Running post-action listener: _resource_record_post_action 04:33:49 INFO - Running post-action listener: set_extra_try_arguments 04:33:49 INFO - ##### 04:33:49 INFO - ##### Running populate-webroot step. 04:33:49 INFO - ##### 04:33:49 INFO - Running pre-action listener: _resource_record_pre_action 04:33:49 INFO - Running main action method: populate_webroot 04:33:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:33:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:33:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:33:49 INFO - '../fennec_ids.txt'], 04:33:49 INFO - 'tests': ['tcheck2']}, 04:33:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:33:49 INFO - '--tppagecycles', 04:33:49 INFO - '7'], 04:33:49 INFO - 'tests': ['tsvgm']}}, 04:33:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:33:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:33:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:33:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:33:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:33:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:33:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:49 INFO - 'talos_options': ['--e10s'], 04:33:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:49 INFO - 'tests': ['damp', 'tps']}, 04:33:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:49 INFO - 'talos_options': ['--e10s'], 04:33:49 INFO - 'tests': ['damp', 'tps']}, 04:33:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:33:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:33:49 INFO - 'other': {'tests': ['a11yr', 04:33:49 INFO - 'ts_paint', 04:33:49 INFO - 'tpaint', 04:33:49 INFO - 'sessionrestore', 04:33:49 INFO - 'sessionrestore_no_auto_restore']}, 04:33:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:33:49 INFO - 'tests': ['a11yr', 04:33:49 INFO - 'ts_paint', 04:33:49 INFO - 'tpaint', 04:33:49 INFO - 'sessionrestore', 04:33:49 INFO - 'sessionrestore_no_auto_restore']}, 04:33:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:33:49 INFO - 'tests': ['a11yr', 04:33:49 INFO - 'ts_paint', 04:33:49 INFO - 'tpaint', 04:33:49 INFO - 'sessionrestore', 04:33:49 INFO - 'sessionrestore_no_auto_restore']}, 04:33:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:33:49 INFO - 'tests': ['a11yr', 04:33:49 INFO - 'ts_paint', 04:33:49 INFO - 'tpaint', 04:33:49 INFO - 'sessionrestore', 04:33:49 INFO - 'sessionrestore_no_auto_restore']}, 04:33:49 INFO - 'other_l64': {'tests': ['a11yr', 04:33:49 INFO - 'ts_paint', 04:33:49 INFO - 'tpaint', 04:33:49 INFO - 'sessionrestore', 04:33:49 INFO - 'sessionrestore_no_auto_restore']}, 04:33:49 INFO - 'other_nol64': {'tests': ['a11yr', 04:33:49 INFO - 'ts_paint', 04:33:49 INFO - 'tpaint', 04:33:49 INFO - 'sessionrestore', 04:33:49 INFO - 'sessionrestore_no_auto_restore']}, 04:33:49 INFO - 'svgr': {'tests': ['tsvgx', 04:33:49 INFO - 'tsvgr_opacity', 04:33:49 INFO - 'tart', 04:33:49 INFO - 'tscrollx', 04:33:49 INFO - 'cart']}, 04:33:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:33:49 INFO - 'tests': ['tsvgx', 04:33:49 INFO - 'tsvgr_opacity', 04:33:49 INFO - 'tart', 04:33:49 INFO - 'tscrollx', 04:33:49 INFO - 'cart']}, 04:33:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:49 INFO - 'tests': ['tp5o']}, 04:33:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:49 INFO - 'talos_options': ['--e10s'], 04:33:49 INFO - 'tests': ['tp5o']}, 04:33:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:49 INFO - 'talos_options': ['--xperf_path', 04:33:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:49 INFO - 'tests': ['tp5n']}, 04:33:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:49 INFO - 'talos_options': ['--e10s', 04:33:49 INFO - '--xperf_path', 04:33:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:49 INFO - 'tests': ['tp5n']}}, 04:33:49 INFO - 'talos.zip': {'path': '', 04:33:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:33:49 INFO - Running post-action listener: _resource_record_post_action 04:33:49 INFO - ##### 04:33:49 INFO - ##### Running create-virtualenv step. 04:33:49 INFO - ##### 04:33:49 INFO - Running pre-action listener: _resource_record_pre_action 04:33:49 INFO - Running main action method: create_virtualenv 04:33:49 INFO - Creating virtualenv /builds/slave/test/build/venv 04:33:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:33:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:33:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:33:49 INFO - Using real prefix '/usr' 04:33:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:33:50 INFO - Installing distribute.............................................................................................................................................................................................done. 04:33:53 INFO - Installing pip.................done. 04:33:53 INFO - Return code: 0 04:33:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:53 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 0x7f8b607aac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af9b70>, '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 0x2b4adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b250>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:33:53 INFO - Using env: {'DISPLAY': ':0', 04:33:53 INFO - 'HOME': '/home/cltbld', 04:33:53 INFO - 'LANG': 'en_US.UTF-8', 04:33:53 INFO - 'LANGUAGE': 'en_US:en', 04:33:53 INFO - 'LOGNAME': 'cltbld', 04:33:53 INFO - 'MAIL': '/var/mail/cltbld', 04:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:53 INFO - 'MOZ_NO_REMOTE': '1', 04:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:53 INFO - 'NO_EM_RESTART': '1', 04:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:53 INFO - 'PWD': '/builds/slave/test', 04:33:53 INFO - 'SHELL': '/bin/bash', 04:33:53 INFO - 'SHLVL': '1', 04:33:53 INFO - 'TERM': 'linux', 04:33:53 INFO - 'TMOUT': '86400', 04:33:53 INFO - 'USER': 'cltbld', 04:33:53 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 04:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:53 INFO - '_': '/tools/buildbot/bin/python'} 04:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:33:55 INFO - Cleaning up... 04:33:55 INFO - Return code: 0 04:33:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:55 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 0x7f8b607aac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af9b70>, '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 0x2b4adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b250>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:33:55 INFO - Using env: {'DISPLAY': ':0', 04:33:55 INFO - 'HOME': '/home/cltbld', 04:33:55 INFO - 'LANG': 'en_US.UTF-8', 04:33:55 INFO - 'LANGUAGE': 'en_US:en', 04:33:55 INFO - 'LOGNAME': 'cltbld', 04:33:55 INFO - 'MAIL': '/var/mail/cltbld', 04:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:55 INFO - 'MOZ_NO_REMOTE': '1', 04:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:55 INFO - 'NO_EM_RESTART': '1', 04:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:55 INFO - 'PWD': '/builds/slave/test', 04:33:55 INFO - 'SHELL': '/bin/bash', 04:33:55 INFO - 'SHLVL': '1', 04:33:55 INFO - 'TERM': 'linux', 04:33:55 INFO - 'TMOUT': '86400', 04:33:55 INFO - 'USER': 'cltbld', 04:33:55 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 04:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:55 INFO - '_': '/tools/buildbot/bin/python'} 04:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:55 INFO - Downloading/unpacking psutil>=0.7.1 04:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:33:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:33:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:57 INFO - Installing collected packages: psutil 04:33:57 INFO - Running setup.py install for psutil 04:33:57 INFO - building 'psutil._psutil_linux' extension 04:33:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:33:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:33:58 INFO - building 'psutil._psutil_posix' extension 04:33:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:33:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:33:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:59 INFO - Successfully installed psutil 04:33:59 INFO - Cleaning up... 04:33:59 INFO - Return code: 0 04:33:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:33: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')]} 04:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33: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')]} 04:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33: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', '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 0x7f8b607aac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af9b70>, '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 0x2b4adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b250>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:33: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:33: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 mozsystemmonitor==0.0.0 04:33:59 INFO - Using env: {'DISPLAY': ':0', 04:33:59 INFO - 'HOME': '/home/cltbld', 04:33:59 INFO - 'LANG': 'en_US.UTF-8', 04:33:59 INFO - 'LANGUAGE': 'en_US:en', 04:33:59 INFO - 'LOGNAME': 'cltbld', 04:33:59 INFO - 'MAIL': '/var/mail/cltbld', 04:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:59 INFO - 'MOZ_NO_REMOTE': '1', 04:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:59 INFO - 'NO_EM_RESTART': '1', 04:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:59 INFO - 'PWD': '/builds/slave/test', 04:33:59 INFO - 'SHELL': '/bin/bash', 04:33:59 INFO - 'SHLVL': '1', 04:33:59 INFO - 'TERM': 'linux', 04:33:59 INFO - 'TMOUT': '86400', 04:33:59 INFO - 'USER': 'cltbld', 04:33:59 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 04:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:59 INFO - '_': '/tools/buildbot/bin/python'} 04:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:33: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 04:33: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 04:33: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 04:33: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 04:33: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 04:33: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 04:34:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:34:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:34:01 INFO - Installing collected packages: mozsystemmonitor 04:34:01 INFO - Running setup.py install for mozsystemmonitor 04:34:01 INFO - Successfully installed mozsystemmonitor 04:34:01 INFO - Cleaning up... 04:34:01 INFO - Return code: 0 04:34:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8b607aac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af9b70>, '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 0x2b4adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b250>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:34:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:34:01 INFO - Using env: {'DISPLAY': ':0', 04:34:01 INFO - 'HOME': '/home/cltbld', 04:34:01 INFO - 'LANG': 'en_US.UTF-8', 04:34:01 INFO - 'LANGUAGE': 'en_US:en', 04:34:01 INFO - 'LOGNAME': 'cltbld', 04:34:01 INFO - 'MAIL': '/var/mail/cltbld', 04:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:01 INFO - 'MOZ_NO_REMOTE': '1', 04:34:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:01 INFO - 'NO_EM_RESTART': '1', 04:34:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:01 INFO - 'PWD': '/builds/slave/test', 04:34:01 INFO - 'SHELL': '/bin/bash', 04:34:01 INFO - 'SHLVL': '1', 04:34:01 INFO - 'TERM': 'linux', 04:34:01 INFO - 'TMOUT': '86400', 04:34:01 INFO - 'USER': 'cltbld', 04:34:01 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 04:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:01 INFO - '_': '/tools/buildbot/bin/python'} 04:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:34:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:34:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:34:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:34:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:04 INFO - Downloading docopt-0.6.1.tar.gz 04:34:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:34:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:34:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:34:04 INFO - Running setup.py install for blobuploader 04:34:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:34:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:34:04 INFO - Running setup.py install for requests 04:34:04 INFO - Running setup.py install for docopt 04:34:05 INFO - Successfully installed blobuploader requests docopt 04:34:05 INFO - Cleaning up... 04:34:05 INFO - Return code: 0 04:34:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:05 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 0x7f8b607aac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af9b70>, '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 0x2b4adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b250>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:34:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:05 INFO - Using env: {'DISPLAY': ':0', 04:34:05 INFO - 'HOME': '/home/cltbld', 04:34:05 INFO - 'LANG': 'en_US.UTF-8', 04:34:05 INFO - 'LANGUAGE': 'en_US:en', 04:34:05 INFO - 'LOGNAME': 'cltbld', 04:34:05 INFO - 'MAIL': '/var/mail/cltbld', 04:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:05 INFO - 'MOZ_NO_REMOTE': '1', 04:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:05 INFO - 'NO_EM_RESTART': '1', 04:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:05 INFO - 'PWD': '/builds/slave/test', 04:34:05 INFO - 'SHELL': '/bin/bash', 04:34:05 INFO - 'SHLVL': '1', 04:34:05 INFO - 'TERM': 'linux', 04:34:05 INFO - 'TMOUT': '86400', 04:34:05 INFO - 'USER': 'cltbld', 04:34:05 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 04:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:05 INFO - '_': '/tools/buildbot/bin/python'} 04:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:05 INFO - Running setup.py (path:/tmp/pip-gqyB2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:05 INFO - Running setup.py (path:/tmp/pip-hmQisQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:05 INFO - Running setup.py (path:/tmp/pip-AemURn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:05 INFO - Running setup.py (path:/tmp/pip-NX4hG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:05 INFO - Running setup.py (path:/tmp/pip-bJtXig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:05 INFO - Running setup.py (path:/tmp/pip-CI3iqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:05 INFO - Running setup.py (path:/tmp/pip-wRshKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:05 INFO - Running setup.py (path:/tmp/pip-3YSAAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:05 INFO - Running setup.py (path:/tmp/pip-uwdMnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:05 INFO - Running setup.py (path:/tmp/pip-KDMBlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:06 INFO - Running setup.py (path:/tmp/pip-BtEDqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:06 INFO - Running setup.py (path:/tmp/pip-IvsnLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:06 INFO - Running setup.py (path:/tmp/pip-opdUfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:06 INFO - Running setup.py (path:/tmp/pip-zmPQ5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:06 INFO - Running setup.py (path:/tmp/pip-SHc6YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:06 INFO - Running setup.py (path:/tmp/pip-q424s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:06 INFO - Running setup.py (path:/tmp/pip-kqMqAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:34:06 INFO - Running setup.py install for manifestparser 04:34:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Running setup.py install for mozcrash 04:34:06 INFO - Running setup.py install for mozdebug 04:34:06 INFO - Running setup.py install for mozdevice 04:34:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:34:06 INFO - Running setup.py install for mozfile 04:34:07 INFO - Running setup.py install for mozhttpd 04:34:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Running setup.py install for mozinfo 04:34:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Running setup.py install for mozInstall 04:34:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Running setup.py install for mozleak 04:34:07 INFO - Running setup.py install for mozlog 04:34:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Running setup.py install for moznetwork 04:34:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Running setup.py install for mozprocess 04:34:07 INFO - Running setup.py install for mozprofile 04:34:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Running setup.py install for mozrunner 04:34:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:34:07 INFO - Running setup.py install for mozscreenshot 04:34:08 INFO - Running setup.py install for moztest 04:34:08 INFO - Running setup.py install for mozversion 04:34:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:34:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:34:08 INFO - Cleaning up... 04:34:08 INFO - Return code: 0 04:34:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34: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')]} 04:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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')]} 04:34:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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/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 0x7f8b607aac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af9b70>, '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 0x2b4adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b250>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:34: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/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:34: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/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:08 INFO - Using env: {'DISPLAY': ':0', 04:34:08 INFO - 'HOME': '/home/cltbld', 04:34:08 INFO - 'LANG': 'en_US.UTF-8', 04:34:08 INFO - 'LANGUAGE': 'en_US:en', 04:34:08 INFO - 'LOGNAME': 'cltbld', 04:34:08 INFO - 'MAIL': '/var/mail/cltbld', 04:34:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:08 INFO - 'MOZ_NO_REMOTE': '1', 04:34:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:08 INFO - 'NO_EM_RESTART': '1', 04:34:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:08 INFO - 'PWD': '/builds/slave/test', 04:34:08 INFO - 'SHELL': '/bin/bash', 04:34:08 INFO - 'SHLVL': '1', 04:34:08 INFO - 'TERM': 'linux', 04:34:08 INFO - 'TMOUT': '86400', 04:34:08 INFO - 'USER': 'cltbld', 04:34:08 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 04:34:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:08 INFO - '_': '/tools/buildbot/bin/python'} 04:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:08 INFO - Running setup.py (path:/tmp/pip-2avgjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:08 INFO - Running setup.py (path:/tmp/pip-drq5mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:08 INFO - Running setup.py (path:/tmp/pip-aLCeQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:08 INFO - Running setup.py (path:/tmp/pip-CVf6hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:08 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)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:08 INFO - Running setup.py (path:/tmp/pip-o5ESm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:08 INFO - Running setup.py (path:/tmp/pip-by4FvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:08 INFO - Running setup.py (path:/tmp/pip-vFjElf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:09 INFO - Running setup.py (path:/tmp/pip-ne2zXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:09 INFO - Running setup.py (path:/tmp/pip-f0sRu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:09 INFO - Running setup.py (path:/tmp/pip-qcGQCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:09 INFO - Running setup.py (path:/tmp/pip-kHY4A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:09 INFO - Running setup.py (path:/tmp/pip-eEB_Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:09 INFO - Running setup.py (path:/tmp/pip-sMyZgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:09 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)) 04:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:09 INFO - Running setup.py (path:/tmp/pip-IXevJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:09 INFO - Running setup.py (path:/tmp/pip-8YPyPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:09 INFO - Running setup.py (path:/tmp/pip-M3nPNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:09 INFO - Running setup.py (path:/tmp/pip-0oqwok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:34:09 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)) 04:34:09 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)) 04:34:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:11 INFO - Downloading blessings-1.5.1.tar.gz 04:34:11 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:34:11 INFO - Installing collected packages: blessings 04:34:11 INFO - Running setup.py install for blessings 04:34:11 INFO - Successfully installed blessings 04:34:11 INFO - Cleaning up... 04:34:11 INFO - Return code: 0 04:34:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:34:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:11 INFO - Reading from file tmpfile_stdout 04:34:11 INFO - Current package versions: 04:34:11 INFO - argparse == 1.2.1 04:34:11 INFO - blessings == 1.5.1 04:34:11 INFO - blobuploader == 1.2.4 04:34:11 INFO - docopt == 0.6.1 04:34:11 INFO - manifestparser == 1.1 04:34:11 INFO - mozInstall == 1.12 04:34:11 INFO - mozcrash == 0.16 04:34:11 INFO - mozdebug == 0.1 04:34:11 INFO - mozdevice == 0.47 04:34:11 INFO - mozfile == 1.2 04:34:11 INFO - mozhttpd == 0.7 04:34:11 INFO - mozinfo == 0.9 04:34:11 INFO - mozleak == 0.1 04:34:11 INFO - mozlog == 3.1 04:34:11 INFO - moznetwork == 0.27 04:34:11 INFO - mozprocess == 0.22 04:34:11 INFO - mozprofile == 0.27 04:34:11 INFO - mozrunner == 6.11 04:34:11 INFO - mozscreenshot == 0.1 04:34:11 INFO - mozsystemmonitor == 0.0 04:34:11 INFO - moztest == 0.7 04:34:11 INFO - mozversion == 1.4 04:34:11 INFO - psutil == 3.1.1 04:34:11 INFO - requests == 1.2.3 04:34:11 INFO - wsgiref == 0.1.2 04:34:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:11 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 0x7f8b607aac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a026c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab3900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af9b70>, '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 0x2b4adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b250>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:11 INFO - Using env: {'DISPLAY': ':0', 04:34:11 INFO - 'HOME': '/home/cltbld', 04:34:11 INFO - 'LANG': 'en_US.UTF-8', 04:34:11 INFO - 'LANGUAGE': 'en_US:en', 04:34:11 INFO - 'LOGNAME': 'cltbld', 04:34:11 INFO - 'MAIL': '/var/mail/cltbld', 04:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:11 INFO - 'MOZ_NO_REMOTE': '1', 04:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:11 INFO - 'NO_EM_RESTART': '1', 04:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:11 INFO - 'PWD': '/builds/slave/test', 04:34:11 INFO - 'SHELL': '/bin/bash', 04:34:11 INFO - 'SHLVL': '1', 04:34:11 INFO - 'TERM': 'linux', 04:34:11 INFO - 'TMOUT': '86400', 04:34:11 INFO - 'USER': 'cltbld', 04:34:11 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 04:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:11 INFO - '_': '/tools/buildbot/bin/python'} 04:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:12 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)) 04:34:12 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)) 04:34:12 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)) 04:34:12 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)) 04:34:12 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)) 04:34:12 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)) 04:34:12 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)) 04:34:12 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)) 04:34:12 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)) 04:34:12 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)) 04:34:12 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)) 04:34:12 INFO - Cleaning up... 04:34:12 INFO - Return code: 0 04:34:12 INFO - Running post-action listener: _resource_record_post_action 04:34:12 INFO - Running post-action listener: _start_resource_monitoring 04:34:12 INFO - Starting resource monitoring. 04:34:12 INFO - ##### 04:34:12 INFO - ##### Running install step. 04:34:12 INFO - ##### 04:34:12 INFO - Running pre-action listener: _resource_record_pre_action 04:34:12 INFO - Running main action method: install 04:34:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:12 INFO - Reading from file tmpfile_stdout 04:34:12 INFO - Detecting whether we're running mozinstall >=1.0... 04:34:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:34:12 INFO - Reading from file tmpfile_stdout 04:34:12 INFO - Output received: 04:34:12 INFO - Usage: mozinstall [options] installer 04:34:12 INFO - Options: 04:34:12 INFO - -h, --help show this help message and exit 04:34:12 INFO - -d DEST, --destination=DEST 04:34:12 INFO - Directory to install application into. [default: 04:34:12 INFO - "/builds/slave/test"] 04:34:12 INFO - --app=APP Application being installed. [default: firefox] 04:34:12 INFO - mkdir: /builds/slave/test/build/application 04:34:12 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'] 04:34:12 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 04:34:26 INFO - Reading from file tmpfile_stdout 04:34:26 INFO - Output received: 04:34:26 INFO - /builds/slave/test/build/application/firefox/firefox 04:34:26 INFO - Running post-action listener: _resource_record_post_action 04:34:26 INFO - ##### 04:34:26 INFO - ##### Running run-tests step. 04:34:26 INFO - ##### 04:34:26 INFO - Running pre-action listener: _resource_record_pre_action 04:34:26 INFO - Running main action method: run_tests 04:34:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:34:26 INFO - Python 2.7.3 04:34:26 INFO - Return code: 0 04:34:26 INFO - grabbing minidump binary from tooltool 04:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af9b70>, '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 0x2b4adc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:34:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:34:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:34:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:34:26 INFO - Return code: 0 04:34:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:34:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:34:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:34:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:34:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:34:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] in /builds/slave/test/build 04:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost 04:34:26 INFO - Using env: {'DISPLAY': ':0', 04:34:26 INFO - 'HOME': '/home/cltbld', 04:34:26 INFO - 'LANG': 'en_US.UTF-8', 04:34:26 INFO - 'LANGUAGE': 'en_US:en', 04:34:26 INFO - 'LOGNAME': 'cltbld', 04:34:26 INFO - 'MAIL': '/var/mail/cltbld', 04:34:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:34:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:26 INFO - 'MOZ_NO_REMOTE': '1', 04:34:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:34:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:26 INFO - 'NO_EM_RESTART': '1', 04:34:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:26 INFO - 'PWD': '/builds/slave/test', 04:34:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:34:26 INFO - 'SHELL': '/bin/bash', 04:34:26 INFO - 'SHLVL': '1', 04:34:26 INFO - 'TERM': 'linux', 04:34:26 INFO - 'TMOUT': '86400', 04:34:26 INFO - 'USER': 'cltbld', 04:34:26 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602', 04:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:26 INFO - '_': '/tools/buildbot/bin/python'} 04:34:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] with output_timeout 3600 04:34:26 INFO - mozversion INFO | application_buildid: 20151124035431 04:34:26 INFO - mozversion INFO | application_changeset: 5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea 04:34:26 INFO - mozversion INFO | application_display_name: Nightly 04:34:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:34:26 INFO - mozversion INFO | application_name: Firefox 04:34:26 INFO - mozversion INFO | application_remotingname: firefox 04:34:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:34:26 INFO - mozversion INFO | application_vendor: Mozilla 04:34:26 INFO - mozversion INFO | application_version: 45.0a1 04:34:26 INFO - mozversion INFO | platform_buildid: 20151124035431 04:34:26 INFO - mozversion INFO | platform_changeset: 5a6b4eae6d8e2d67b0c50fe84ed30b4794bf25ea 04:34:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:34:26 INFO - mozversion INFO | platform_version: 45.0a1 04:34:26 INFO - 2015-11-24 04:34:26,904 DEBUG : using testdate: 1448368466 04:34:26 INFO - 2015-11-24 04:34:26,904 DEBUG : actual date: 1448368466 04:34:26 INFO - 2015-11-24 04:34:26,955 INFO : starting webserver on 'localhost:49978' 04:34:26 INFO - 2015-11-24 04:34:26,956 INFO : Starting test suite talos-linux64-ix-019 04:34:26 INFO - 2015-11-24 04:34:26,956 INFO : Starting test dromaeo_css 04:34:26 INFO - 2015-11-24 04:34:26,956 DEBUG : operating with platform_type : linux_ 04:34:26 INFO - 2015-11-24 04:34:26,957 INFO : Initialising browser for dromaeo_css test... 04:34:26 INFO - 2015-11-24 04:34:26,977 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTBrb2G/profile http://localhost:49978/getInfo.html 04:34:32 INFO - 2015-11-24 04:34:32,537 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:34:32 INFO - 2015-11-24 04:34:32,537 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:34:32 INFO - 2015-11-24 04:34:32,538 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:34:32 INFO - 2015-11-24 04:34:32,538 DEBUG : BROWSER_OUTPUT: __metrics 04:34:32 INFO - 2015-11-24 04:34:32,694 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:34:33 INFO - 2015-11-24 04:34:33,985 INFO : Browser initialized. 04:34:33 INFO - 2015-11-24 04:34:33,986 INFO : Running cycle 1/1 for dromaeo_css test... 04:34:33 INFO - 2015-11-24 04:34:33,986 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTBrb2G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:34:45 INFO - 2015-11-24 04:34:45,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 140423168 04:34:45 INFO - 2015-11-24 04:34:45,741 DEBUG : BROWSER_OUTPUT: 04:35:36 INFO - 2015-11-24 04:35:36,791 DEBUG : BROWSER_OUTPUT: 1448368536790 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:37:48 INFO - 2015-11-24 04:37:48,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49978/tests/dromaeo/cssquery-ext.html) 04:37:50 INFO - 2015-11-24 04:37:50,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 237862912 04:37:50 INFO - 2015-11-24 04:37:50,020 DEBUG : BROWSER_OUTPUT: 04:40:52 INFO - 2015-11-24 04:40:52,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/dromaeo/cssquery-ext.html (next: http://localhost:49978/tests/dromaeo/cssquery-jquery.html) 04:40:53 INFO - 2015-11-24 04:40:53,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 217292800 04:40:53 INFO - 2015-11-24 04:40:53,230 DEBUG : BROWSER_OUTPUT: 04:43:55 INFO - 2015-11-24 04:43:55,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49978/tests/dromaeo/cssquery-mootools.html) 04:43:55 INFO - 2015-11-24 04:43:55,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 217460736 04:43:55 INFO - 2015-11-24 04:43:55,822 DEBUG : BROWSER_OUTPUT: 04:46:57 INFO - 2015-11-24 04:46:57,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49978/tests/dromaeo/cssquery-prototype.html) 04:46:58 INFO - 2015-11-24 04:46:58,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 204054528 04:46:58 INFO - 2015-11-24 04:46:58,324 DEBUG : BROWSER_OUTPUT: 04:50:01 INFO - 2015-11-24 04:50:01,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49978/tests/dromaeo/cssquery-yui.html) 04:50:01 INFO - 2015-11-24 04:50:01,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 208322560 04:50:01 INFO - 2015-11-24 04:50:01,642 DEBUG : BROWSER_OUTPUT: 04:53:04 INFO - 2015-11-24 04:53:04,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/dromaeo/cssquery-yui.html (next: http://localhost:49978/tests/dromaeo/cssquery-dojo.html) 04:53:04 INFO - 2015-11-24 04:53:04,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 244850688 04:53:04 INFO - 2015-11-24 04:53:04,443 DEBUG : BROWSER_OUTPUT: 04:53:04 INFO - 2015-11-24 04:53:04,444 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:53:04 INFO - 2015-11-24 04:53:04,444 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:53:04 INFO - 2015-11-24 04:53:04,444 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:53:04 INFO - 2015-11-24 04:53:04,444 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:53:04 INFO - 2015-11-24 04:53:04,444 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2511.6609257750206;2626.1596289187455;2637.3670319123403;2642.6432431621724;2648.9205323840292;4369.235383807837;4517.367568540403;4530.7281563106235;4531.977340113295;4549.590536851682;4429.46846378435;4435.379046933432;4505.639548836093;4511.458624965009;4556.794944227509;4152.77159756214;4154.813033413504;4185.434966279559;4310.137972405516;4352.455943007124;4300.870973870773;4364.083542456088;4370.2133615949115;4372.540883207265;4420.961074147573;4100.79496025199;4169.624733773944;4206.936895946563;4216.388623649585;4287.399764033038;4293.699441039129;4302.827886884521;4308.418363520916;4316;4345.239583072981;4283.336082907154;4286.464191976003;4297.892552686208;4309.439772829513;4311.331743579719;4323.632491238249;4450.554944505556;4465.062336909253;4491.30384790358;4592.885177870547;4815.277708343741;4831.444383895827;4922.507749225085;4932.2108462646165;4972.179590367621;4931.876703082416;4933.432655244657;4937.35814344133;4950.331705219785;4959.355283813081;4380.452443444569;4481.910361792746;4484.775761211927;4486.685931984795;4544.88637784058;5000.6999580024585;5002.874928126753;5004.2493625956395;5031.798728050837;5081.5426611605135;4799.304100905419;4804.855854324376;4804.942912559231;4812.614990800727;4830.275458681155;4644.86065418038;4755.239161734106;4764.404449443819;4771.165046116916;4911.68074075184;4907.018596280758;4960.404751429852;4964.553190212898;4967.652264341534;4968.1554135797005;4947.134251506044;4954;4955.752212389366;4955.90088198234;4965.379327584052;3914.8434062637743;3962.980185099114;4004.3392840181627;4009.1781184857036;4187.078842654611;3534.1164708822794;3596.7662101963288;3639.927201455956;3644.3986742187244;3679.098620837858;4312.310030395121;4320.805563749639;4324.891877703082;4333.501647310537;4360.018995726;4755.500672429345;4972.276873546749;4989.426215985208;4989.451160372356;4991.600671946236;4147.087640719037;4173.7078404512;4200.957990420118;4244.490661120685;4294.184105020036;4313.158934007838;4341.34879768031;4343.4353534041;4382.364557139197;4407.933880991788;4457.086297309109;4670.813167473263;4674.447419960922;4676.368690226844;4680.485146633868;4821.710697358169;4908.92636610444;4947.406311242674;4949.010197960494;4959.429665588359;4618.445786505641;4677.929831052469;4685.929711054405;4690.648201384842;4734.952650473451;4720.480747117883;4857.222844344888;4876.024795041077;4877.268409738567;4931.16170251051;4840.1287768200655;4911.189653707098;4911.926321105115;4933.605311574994;4978.502149784992;4805.303231031551;4833.130036593447;4838.758062096951;4838.951610483991;4871.269309603588;4626.6530010250035;4798.880027999328;4821.614270858253;4826.686265392738;4871.707697538159;4572.702774319659;4581;4620.306953956799;4649.395578574764;4656;4819.879503012453;4838.806447742051;4854.344663470528;4854.344663470528;4889.853304400874;4720.834770783006;4735.83424580138;4742.454617718869;4745.264484004984;4788.3056956741775 04:53:04 INFO - 2015-11-24 04:53:04,444 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.4496615799596;573.0458786121108;574.8591595059208;578.5747475605432;580.6487075319432;26272.868635656818;26789;37557.81221093897;38394.424083638696;38425.61574384255;40411;40877.795611021975;40894.795526022404;41010.38484422729;41045.58954410455;6894.689738961759;7736.226377362275;7744.419168562352;7859.214078592152;7920.049594048723;6947;10010.849837252446;10015.949920250388;10244.129249013842;10255.538500767447;9792.657256996006;9901.306908516406;9927.106560409562;9928.255380846465;9955.253355998293;6897.689603967833;7091.219965803757;9780.462074585896;9882.258830587698;10095.899041009568;9677.322587418883;9885.604575816958;9896.90103098967;9906.801863962752;10017.949910250401;37514.24971500582;37940.43089353662;37940.62059379398;37966.24067518634;38010.80994595037;2839.2617919340914;3001.639803223605;3026.4854974654363;3391;3412.709919656832;26965.730342696716;27561.173164805088;27785.722142778515;27900.302492437648;27942.947068668225;3292.111129994912;3302.9174270643184;3315.900522984314;3343.0806528204694;3456.5679290088738;221170;221175;221800.6729899053;221909;222742;55211;55611.72194139003;55622.72188639031;55649;55656.87774344819;48590.757046214545;49343.50656493461;65061;66407.69126932934;66554.67394619335;12654.304013279174;12751.42618582166;12756.234625922474;12778.872211277954;12826.743465130645;10354.689359319233;10400.375977441377;10423.218258630633;10464.686059418229;10534.947325263325;18856.151473183465;19064.14211360492;19082.94672852337;19113.808861911482;19193.712094318595;7285.198628150899;7503.084822672465;7557.735479258199;7638.121616014229;7651.808704782425;822.9012518497699;902.2015516268019;926.1294383279695;984.4044353166374;990.0990099009866;26226.737732622812;26424.207273781816;26438.339041524116;26444.47111057768;29769;903.4037535226851;921.8386782313069;939.2110627073291;954.2413781043948;996.2776986684596;15192.696146077016;16126.838731612534;16192.676146477004;16209;16251;330363;336984;337587;337916;338148;48109.5189048112;48579.757101214265;48621.270680939815;48644;48650.756746216044;1165.6677846813618;1195.6711904226233;1206.0652993929775;1208.371646743706;1208.86098098718;25977.35056623524;26793.732062679122;27586.89652413881;28032;30060.398792024476;41370.379444308965;42012;42033.36949945692;42590.36114458224;42753.35869961891;241917;244710;245435;245890;246328;23568.52862942766;26020.479590407707;27979.720202798526;28082;29041.128766137048;33189;33426.16434589155;44485.555144449434;45974.54025459703;45982.310265345375;33668.83165584156;34030.149246269044;34040;34103;34612.30775384428;28439.411234006337;34436.48345274773;34532.136696582784;34579.308413832085;34773.82613086919;27451.450970980866;35217.295654087284;35230.47154292739;35287.64712352843;35309.29381412409;25914.87042564775;26654.733452665227;29093.41813163767;29699.406011880073;29844.253893651963;24782.752172478045;25643;25759.613605795552;26056;26432.471350573265 04:53:04 INFO - 2015-11-24 04:53:04,444 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.08785296508114;332.9550510681057;334.52831507574325;334.9095744149079;339.526360726786;12355.382230888465;12727.490900363997;14715.779263311046;15113.244337783108;15383.69232615347;11732.882671173285;14150.15099094055;14767.483138090169;15371.692566148671;15374.538763837103;4409.228385032607;5447.1829225616175;5511.200875872996;5532.059549876531;5600.411956744524;5317.494837990384;5336.466353364672;5363.731813409334;5369.24830523727;5374.381946076192;5198.324217851674;5264.684118952856;5286.814961476349;5438.320209973754;5542.4457554244655;5535.114381698929;5548.58385621078;5552.666839989613;5575.442455754433;5586.692731899744;5385.35375754908;5398.703071331075;5768.105943578752;5970.910436343458;5980.28236611605;20535.794642053537;21035.158593656237;21301.573968520544;21608.675869861963;21643.45891352713;1747.3971479839436;1871.737956686065;1911.8852868827914;2014.1238561225914;2026.3414390323203;10857.891421085767;12279.57021504252;12478;13246.337683115806;13956.441742330295;1716.2019660857761;1739.9130043497773;1757.5869670627392;1846.9168887400099;1859.8168060533626;59009.40990590125;62980;64045.67977160131;65171.348286517;66297.3370266296;15440.613984650248;15461.613459663598;15492.51418430844;15496.457623983106;15496.767548486781;18493.445196644123;18793.718094228323;20433.48916277105;22965.54068918646;22975.655365169536;8452.830943381221;8523.573821309034;8559.786005349792;8612.224899759052;8639.95680021596;7044.718211271595;7051.330123638246;7070.717171313193;7099.432045436352;7171.1394632644415;7569.432292578079;7586.431017673696;7618.390528757686;7644.464887457824;7702;2900.8694608742658;2970.5395663672166;3015.4873671475902;3030.863611137504;3059.0785799561368;827.0945449490641;837.9287760540301;847.2459511035183;884.5090974509209;928.5078908178676;15450.150241736588;15825.920870395805;15912.52262432129;16160.595985100232;16228;806.435495153395;831.580052073711;844.9915500844913;854.1629203380721;863.4560227056913;7731.458797884206;8836.160564746338;9189.954050229706;9207.953960230156;9339.813203735886;312888;449181;452469;456505;458219;61579.38420615826;62008;62279.6886015567;62969.37030629726;64029.67985160137;1018.0532105142289;1068.5725709716176;1071.394662015974;1073.4042606353548;1088.7223757941833;8546.78633034179;8951.955240223757;9244.537773111182;9446.433214007182;13691.110077844909;31007.84496077505;31275.374492509567;31950.68049319477;33328.1667958303;33470.4979425304;46268.305975411065;46828.7658561705;47060.7646961763;47541.76229118832;47759.52240477551;13584.25286609246;13758.793618095537;13765.242911639956;13778.517751878637;14191;16810.915945420686;17001.744973825156;17010.48968530946;17440.563985900455;17597.032163230633;14439.711205776035;14462.421503140178;14738.11571305725;14802.185879776716;14824.481143159937;13953.720925581634;14463.92768036153;14490.85509144895;14588.854111459174;15116.54650360491;14821.703565928836;14879.702405952037;15031.699366012399;15315.004524706304;15340.693186135992;13499.122557033761;13508.662283442993;13708.86291137076;13816.309184540934;13837.308134593432;13487.59537213846;13978.301084945915;14448.133112013313;14786;14850.108993460426 04:53:04 INFO - 2015-11-24 04:53:04,448 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1184.2420850655587;1568.3804897065656;1604.0856711674344;1647.5551601067716;1661.1279078483794;5634.295713035871;6290;6440.581362211453;6440.838979025527;6453.838654033651;6447.097406363101;6608.405243528082;6627.436667883236;6683.966580167104;6719.462443004561;1679.3030892179793;1732.861371090316;1735.3232239426634;2009.4172689919906;2032.6442872497328;2031.055559164988;2080.2927004818434;2081.7918208179212;2082.5834833033377;2082.635538780715;1990.9800901991011;2009.2164056018164;2017.4855411869953;2037.9694304585444;2038.6534289170802;2007.7389939307795;2054.897255137237;2082.531430428157;2087.7390326209224;2088.2377932054765;2008.6183625111182;2025.382258411184;2025.6151331247015;2027.6654352031896;2028.4421784009514;6577.112089867855;6668.799936001928;6697.19633643961;6745.258021617618;6753.088333075021;3781.6596506314563;3866.516685414323;3867.284552357795;3874.9612503874882;3877.3602355611292;2596.532624127656;2611.5299246135687;2611.8041146913865;2626.5534859074005;2629.3426643339167;759.3355813663045;910.8633704944245;912.9041450647719;927.9953600232024;944.6929747831913;8927.776805579848;9006.144416280444;9019.729408117766;9022.639094436281;9026.819463610691;3802.961970380316;3808.333541630204;3864.9613503864603;3879.282332768447;3882.786446745456;7740.4194685398825;7744.883826742604;7746.961265193638;7756.457048006585;7757.961210194026;4007.338789099824;4012.077222238843;4079.89800254996;4084.0606660468256;4090.8159132839096;3664.523611930432;3668.926621467556;3670.0457880951144;3670.376036073874;3687.022938921188;3316.403047451434;3319.137024373632;3331.900042998714;3365.6634336566635;3368.79787212768;1037.123630532199;1040.245821779219;1047.3768107975743;1051.2746205118444;1051.2851261142343;1075.5536452372335;1091.317926296065;1102.5699977008974;1115.743379022813;1118.1334465789078;6458.257300410419;6494.253160886558;6514.250861150934;6514.250861151028;6515.543911926215;424.7897290841053;425.53829095431183;436.1342734671674;436.5874248834884;438.51982079622763;4985.576226020757;5022.949770502321;5078.771455284521;5114.41184263807;5114.616403769732;6948.583085014814;7402.555846649218;7800.258975397328;7815.374770018499;7972.043354797462;7724.0731112266885;7731.304182623591;7748.728794492165;7754.340881025176;7827.6477558510005;5948.643081415129;6033.306169790442;6075;6075.875962946958;6089.756409743649;5811.738471768696;5940.138679891478;5943.732532035982;5943.940560594338;5948.196993405835;6376.553641245068;6832.111825462658;6860.3139686031;6890;6903.585784852925;6832.111825462658;7040.57756534589;7138.428925685829;7140.214576396696;7158.713651453883;5830.883382332415;5924.6149000314845;5928.288605367384;5929.080992446177;5933.575941773857;6378.808635740936;6423.582467139621;6423.614583125028;6496.902546461902;6498.057781621733;6104.053871649901;6112.541559382975;6139.109829074849;6204.5967012144065;6313.3686631336495;5912.320083190488;6015.578909476295;6017.699115044143;6018.668973206516;6126.111713801563;6008.54935879802;6069.180660610761;6070.848228794315;6095.817125486243;6103.908441373294;5644.576656750843;5681.375048744718;5699.943000569941;5700.828975130753;5709.486146246858;5772.191893135048;5823.592348535732;5840.1531777892815;5844.853878653068;5847.678377689268 04:53:04 INFO - 2015-11-24 04:53:04,449 DEBUG : BROWSER_OUTPUT: |4;prototype.html;290.3612053482339;299.72874548533576;305.54016205610566;316.0691762758677;316.9017604542592;5253.658512196705;5311.336082989622;5320.866978325544;5330.733463326827;5350.625456218061;5230.189320655295;5231.163013917774;5232.686038837673;5242.475752424755;5248.002879452902;3874.8256328465145;4127.9174416511805;4161.313383291753;4171;4180.811863466151;3934.154156856275;3982.183652351261;4042.7776472294013;4049.858254961077;4058.6144316289906;3986.9800650996704;4041.625847211962;4051;4053.4730485036903;4059.5940405959464;3899.941500877489;3943.7633741975287;3977.105151340954;4052.392141178832;4062.857799976987;3525.2773181497732;3526.3299973005046;3527.224010717638;3528.3648943190215;3543.8936831895085;5032.4212715537815;5037.942032173248;5051.166557518042;5052.216906379517;5071.366079240095;4578.542145785428;4581;4581.931271030937;4583.610393116589;4588.793504292282;5332.413434522199;5470.91793623096;5474.069408200576;5475.945240547583;5488.9725551371985;3808.8095595220407;3851.4030325299623;3851.6340947609933;3857.5756666766633;3858.3247931612136;5723.856903577403;5777;5866.296044474648;5867.207926929896;5873.911891321633;3894.889956362423;3899.29812633723;3900.7464514806447;3902.8829135125993;3908.843646254118;3843.423486477051;3946.940795888064;3959.6238357356006;3964.5837187095517;3969.821358038895;4554.157480866051;4554.180247555406;4554.817807287738;4562.201614717477;4562.977185114053;5494.670319780826;5498.3127109111365;5506.229127922094;5506.449355064542;5507.256520369779;1419.6876687128815;1451.7241724072392;1452.3174108169144;1453.6075259679826;1454.614527150306;959.836827739286;960.4669408478222;994.3884511025811;998.0269237493386;1015.7308313296983;4783.689060211075;4827.372441582572;4829.106615276115;4834.734089625104;4841.419029716457;5692.861427714391;5694.288213973254;5698.601097923189;5699.401562835926;5710.8001219957105;4819.903601927942;4823.1800593899125;4824.890275236715;4827;4829.6860704054825;2851.21591562322;2922.503174460347;3045.9238519037203;3087.0893086539527;3087.1047396255285;5337.653052551572;5417.891642167135;5426.321709786277;5430.5384042356845;5433.239346491494;5926.496247818897;5927.851803704942;5931.58478906481;5935.554833387427;5941.138534912414;5197.8440646780655;5238.790448382022;5318.946810531846;5410.621256512007;5411.080116380146;5739.483446489836;5743.540516758733;5757.050086735641;5757.596968212352;5767.077267637158;5605.215269862304;5633.521150702236;5633.915491267552;5634.943650563442;5639.802606908738;5288.629795914249;5381.354237491526;5484;5491.890162196813;5497.752601132878;4066.898327541835;4077.7145599808914;4077.857274995361;4079;4081.7755023472805;5756.395578464201;5758.942410575841;5764.279465066867;5768.50967667753;5769.769209231584;5528.7235638218735;5532.30846144232;5536.695481748381;5543.279373681396;5545.973994810812;5409.0804563223555;5532.1425179097305;5536.058869992031;5542.445755424425;5542.7782888684005;5480.72596370172;5509.393966663744;5513.917291240715;5514.558835293086;5514.558835293247;5682.886342273214;5690.430956904276;5694.231278777478;5695.316562012419;5696.344920334214;5444.482774136451;5521.641093328921;5540.252065971043;5549.500544950974;5553.305836770403 04:53:04 INFO - 2015-11-24 04:53:04,450 DEBUG : BROWSER_OUTPUT: |5;yui.html;683.6923384476987;693.6601065477918;717.946154038447;738.5052015149856;759.513911096898;11294.265872718268;11502.482388292527;11565.190436669436;11582;12819.487220511191;13031.934840325808;13223.404946777395;13225.470981160766;13255.072144949832;13269.535566255183;609.9176611157503;617.0066193428598;753.8643044252033;762.5805806806235;778.2217782217782;766.333290037668;768.2854944901239;772.9265719756643;773.4353921637208;773.686656903952;640.0974625777654;799.4284086877881;807.144426907477;807.29765104359;807.3379828540599;643.4305639509045;794.3049831397527;817.6034623207739;818.0428898189133;818.8034871630825;578.9594728369016;586.1354502109397;591.5297338615811;591.6361437715774;592.4401440638599;11394.829077563843;11574.826377604342;11639.592614258545;11683.7079073023;11689.883101168965;10728.678139655824;11202.327860328325;11246.325220486715;11468.541258349656;11503.309801411942;9028;9134.406263592846;9143.77140571491;9201.631934722604;9314.767130821716;3186.0769820276337;3192.696693814084;3210.5665735125694;3216.437123503401;3290.7696461247483;40327.59672403268;40519.189616207805;40840;41059.38410923839;41147.177056459004;9183.862242066374;9220.354575179806;9242.214411775074;9582.28132890036;9647.372920760128;15884.364625414853;15896;16655.583610409838;16888.15559222034;16889.408870689465;6206.937930620727;6239.376062393724;6347.841303967345;6388.169537960129;6499.512536559682;3433.484977253432;3493.8427770750377;3608.1701208721615;3608.783472991629;3736.794476303775;2679.4775018871524;2710.0785732850927;2715.1718725788824;2717.184844546628;2720.047983205902;472.6974736168855;479.3576607346173;497.59197458084026;499.4356377293635;501.0830180769184;482.16103979076854;506.97337890771485;514.3236643813448;518.902521167735;522.4435975685958;6987.965060174768;7228.385587225145;7299.5255308404785;7299.744508942268;7437.107547094275;418.44764910318696;517.9197224430219;529.7430746088144;548.934127904654;552.3234038303127;3450.7929524228625;3544.8404821783083;3569.803660798681;3570.1610121621397;3650.762700424464;47779;48816.511834881196;51576.48423515792;53120.734396327774;53580.73209633927;43153.35269970953;43176.352354714705;43322;43617;45108.3233751494;39355.40966885499;39708.40437393441;40332.39501407481;40425.39361909574;40562;7489.66296516669;7532.962335188289;7833.280971829593;7839;7927;30730.692693072782;31040.22399440032;31408.685913140576;31510.68489315169;31957.840210798797;37419.81290093532;37433;37602.24795504129;37888.968882489884;37976;8986.14631609996;9321.766955826159;9329.860052099088;9430.434173949585;9533.761655958657;10196.3372380795;10475.319104258198;10691.037806597444;10758.300710453796;10904.836427453753;9482.57328420209;9525.809483810424;9596.616135354787;9937.751556210864;10450.843237351597;9255.444673319622;9322.533873306444;9526;10008.698869146965;10036.698899033041;9471.526423678652;9548.713538593853;9623.951880240555;9657.082577155159;9912.256580756328;8115.634796434057;8205.261526462647;8445.746627601182;8577.742667719978;8623.310135189044;7529.209433009455;7916.762497125095;7943;7987.361011119213;8127.75616731499 04:53:04 INFO - 2015-11-24 04:53:04,450 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:53:04 INFO - 2015-11-24 04:53:04,450 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:53:04 INFO - 2015-11-24 04:53:04,450 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,897 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: __startTimestamp1448369584438__endTimestamp 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4533.60 Median:4649.40 stddev:473.07 (10.2%) stddev-sans-first:447.14 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: Values: 2511.7 2626.2 2637.4 2642.6 2648.9 4369.2 4517.4 4530.7 4532.0 4549.6 4429.5 4435.4 4505.6 4511.5 4556.8 4152.8 4154.8 4185.4 4310.1 4352.5 4300.9 4364.1 4370.2 4372.5 4421.0 4100.8 4169.6 4206.9 4216.4 4287.4 4293.7 4302.8 4308.4 4316.0 4345.2 4283.3 4286.5 4297.9 4309.4 4311.3 4323.6 4450.6 4465.1 4491.3 4592.9 4815.3 4831.4 4922.5 4932.2 4972.2 4931.9 4933.4 4937.4 4950.3 4959.4 4380.5 4481.9 4484.8 4486.7 4544.9 5000.7 5002.9 5004.2 5031.8 5081.5 4799.3 4804.9 4804.9 4812.6 4830.3 4644.9 4755.2 4764.4 4771.2 4911.7 4907.0 4960.4 4964.6 4967.7 4968.2 4947.1 4954.0 4955.8 4955.9 4965.4 3914.8 3963.0 4004.3 4009.2 4187.1 3534.1 3596.8 3639.9 3644.4 3679.1 4312.3 4320.8 4324.9 4333.5 4360.0 4755.5 4972.3 4989.4 4989.5 4991.6 4147.1 4173.7 4201.0 4244.5 4294.2 4313.2 4341.3 4343.4 4382.4 4407.9 4457.1 4670.8 4674.4 4676.4 4680.5 4821.7 4908.9 4947.4 4949.0 4959.4 4618.4 4677.9 4685.9 4690.6 4735.0 4720.5 4857.2 4876.0 4877.3 4931.2 4840.1 4911.2 4911.9 4933.6 4978.5 4805.3 4833.1 4838.8 4839.0 4871.3 4626.7 4798.9 4821.6 4826.7 4871.7 4572.7 4581.0 4620.3 4649.4 4656.0 4819.9 4838.8 4854.3 4854.3 4889.9 4720.8 4735.8 4742.5 4745.3 4788.3 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42973.10 Median:18710.57 stddev:71243.31 (380.8%) stddev-sans-first:71372.01 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: Values: 564.4 573.0 574.9 578.6 580.6 26272.9 26789.0 37557.8 38394.4 38425.6 40411.0 40877.8 40894.8 41010.4 41045.6 6894.7 7736.2 7744.4 7859.2 7920.0 6947.0 10010.8 10015.9 10244.1 10255.5 9792.7 9901.3 9927.1 9928.3 9955.3 6897.7 7091.2 9780.5 9882.3 10095.9 9677.3 9885.6 9896.9 9906.8 10017.9 37514.2 37940.4 37940.6 37966.2 38010.8 2839.3 3001.6 3026.5 3391.0 3412.7 26965.7 27561.2 27785.7 27900.3 27942.9 3292.1 3302.9 3315.9 3343.1 3456.6 221170.0 221175.0 221800.7 221909.0 222742.0 55211.0 55611.7 55622.7 55649.0 55656.9 48590.8 49343.5 65061.0 66407.7 66554.7 12654.3 12751.4 12756.2 12778.9 12826.7 10354.7 10400.4 10423.2 10464.7 10534.9 18856.2 19064.1 19082.9 19113.8 19193.7 7285.2 7503.1 7557.7 7638.1 7651.8 822.9 902.2 926.1 984.4 990.1 26226.7 26424.2 26438.3 26444.5 29769.0 903.4 921.8 939.2 954.2 996.3 15192.7 16126.8 16192.7 16209.0 16251.0 330363.0 336984.0 337587.0 337916.0 338148.0 48109.5 48579.8 48621.3 48644.0 48650.8 1165.7 1195.7 1206.1 1208.4 1208.9 25977.4 26793.7 27586.9 28032.0 30060.4 41370.4 42012.0 42033.4 42590.4 42753.4 241917.0 244710.0 245435.0 245890.0 246328.0 23568.5 26020.5 27979.7 28082.0 29041.1 33189.0 33426.2 44485.6 45974.5 45982.3 33668.8 34030.1 34040.0 34103.0 34612.3 28439.4 34436.5 34532.1 34579.3 34773.8 27451.5 35217.3 35230.5 35287.6 35309.3 25914.9 26654.7 29093.4 29699.4 29844.3 24782.8 25643.0 25759.6 26056.0 26432.5 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: 04:53:04 INFO - 2015-11-24 04:53:04,451 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25774.05 Median:17033.46 stddev:70085.71 (411.5%) stddev-sans-first:70256.29 04:53:04 INFO - 2015-11-24 04:53:04,453 DEBUG : BROWSER_OUTPUT: Values: 331.1 333.0 334.5 334.9 339.5 12355.4 12727.5 14715.8 15113.2 15383.7 11732.9 14150.2 14767.5 15371.7 15374.5 4409.2 5447.2 5511.2 5532.1 5600.4 5317.5 5336.5 5363.7 5369.2 5374.4 5198.3 5264.7 5286.8 5438.3 5542.4 5535.1 5548.6 5552.7 5575.4 5586.7 5385.4 5398.7 5768.1 5970.9 5980.3 20535.8 21035.2 21301.6 21608.7 21643.5 1747.4 1871.7 1911.9 2014.1 2026.3 10857.9 12279.6 12478.0 13246.3 13956.4 1716.2 1739.9 1757.6 1846.9 1859.8 59009.4 62980.0 64045.7 65171.3 66297.3 15440.6 15461.6 15492.5 15496.5 15496.8 18493.4 18793.7 20433.5 22965.5 22975.7 8452.8 8523.6 8559.8 8612.2 8640.0 7044.7 7051.3 7070.7 7099.4 7171.1 7569.4 7586.4 7618.4 7644.5 7702.0 2900.9 2970.5 3015.5 3030.9 3059.1 827.1 837.9 847.2 884.5 928.5 15450.2 15825.9 15912.5 16160.6 16228.0 806.4 831.6 845.0 854.2 863.5 7731.5 8836.2 9190.0 9208.0 9339.8 312888.0 449181.0 452469.0 456505.0 458219.0 61579.4 62008.0 62279.7 62969.4 64029.7 1018.1 1068.6 1071.4 1073.4 1088.7 8546.8 8952.0 9244.5 9446.4 13691.1 31007.8 31275.4 31950.7 33328.2 33470.5 46268.3 46828.8 47060.8 47541.8 47759.5 13584.3 13758.8 13765.2 13778.5 14191.0 16810.9 17001.7 17010.5 17440.6 17597.0 14439.7 14462.4 14738.1 14802.2 14824.5 13953.7 14463.9 14490.9 14588.9 15116.5 14821.7 14879.7 15031.7 15315.0 15340.7 13499.1 13508.7 13708.9 13816.3 13837.3 13487.6 13978.3 14448.1 14786.0 14850.1 04:53:04 INFO - 2015-11-24 04:53:04,453 DEBUG : BROWSER_OUTPUT: 04:53:04 INFO - 2015-11-24 04:53:04,453 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4653.96 Median:5842.50 stddev:2360.52 (40.4%) stddev-sans-first:2352.73 04:53:04 INFO - 2015-11-24 04:53:04,453 DEBUG : BROWSER_OUTPUT: Values: 1184.2 1568.4 1604.1 1647.6 1661.1 5634.3 6290.0 6440.6 6440.8 6453.8 6447.1 6608.4 6627.4 6684.0 6719.5 1679.3 1732.9 1735.3 2009.4 2032.6 2031.1 2080.3 2081.8 2082.6 2082.6 1991.0 2009.2 2017.5 2038.0 2038.7 2007.7 2054.9 2082.5 2087.7 2088.2 2008.6 2025.4 2025.6 2027.7 2028.4 6577.1 6668.8 6697.2 6745.3 6753.1 3781.7 3866.5 3867.3 3875.0 3877.4 2596.5 2611.5 2611.8 2626.6 2629.3 759.3 910.9 912.9 928.0 944.7 8927.8 9006.1 9019.7 9022.6 9026.8 3803.0 3808.3 3865.0 3879.3 3882.8 7740.4 7744.9 7747.0 7756.5 7758.0 4007.3 4012.1 4079.9 4084.1 4090.8 3664.5 3668.9 3670.0 3670.4 3687.0 3316.4 3319.1 3331.9 3365.7 3368.8 1037.1 1040.2 1047.4 1051.3 1051.3 1075.6 1091.3 1102.6 1115.7 1118.1 6458.3 6494.3 6514.3 6514.3 6515.5 424.8 425.5 436.1 436.6 438.5 4985.6 5022.9 5078.8 5114.4 5114.6 6948.6 7402.6 7800.3 7815.4 7972.0 7724.1 7731.3 7748.7 7754.3 7827.6 5948.6 6033.3 6075.0 6075.9 6089.8 5811.7 5940.1 5943.7 5943.9 5948.2 6376.6 6832.1 6860.3 6890.0 6903.6 6832.1 7040.6 7138.4 7140.2 7158.7 5830.9 5924.6 5928.3 5929.1 5933.6 6378.8 6423.6 6423.6 6496.9 6498.1 6104.1 6112.5 6139.1 6204.6 6313.4 5912.3 6015.6 6017.7 6018.7 6126.1 6008.5 6069.2 6070.8 6095.8 6103.9 5644.6 5681.4 5699.9 5700.8 5709.5 5772.2 5823.6 5840.2 5844.9 5847.7 04:53:04 INFO - 2015-11-24 04:53:04,453 DEBUG : BROWSER_OUTPUT: 04:53:04 INFO - 2015-11-24 04:53:04,453 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4584.21 Median:5240.63 stddev:1354.33 (25.8%) stddev-sans-first:1319.23 04:53:04 INFO - 2015-11-24 04:53:04,453 DEBUG : BROWSER_OUTPUT: Values: 290.4 299.7 305.5 316.1 316.9 5253.7 5311.3 5320.9 5330.7 5350.6 5230.2 5231.2 5232.7 5242.5 5248.0 3874.8 4127.9 4161.3 4171.0 4180.8 3934.2 3982.2 4042.8 4049.9 4058.6 3987.0 4041.6 4051.0 4053.5 4059.6 3899.9 3943.8 3977.1 4052.4 4062.9 3525.3 3526.3 3527.2 3528.4 3543.9 5032.4 5037.9 5051.2 5052.2 5071.4 4578.5 4581.0 4581.9 4583.6 4588.8 5332.4 5470.9 5474.1 5475.9 5489.0 3808.8 3851.4 3851.6 3857.6 3858.3 5723.9 5777.0 5866.3 5867.2 5873.9 3894.9 3899.3 3900.7 3902.9 3908.8 3843.4 3946.9 3959.6 3964.6 3969.8 4554.2 4554.2 4554.8 4562.2 4563.0 5494.7 5498.3 5506.2 5506.4 5507.3 1419.7 1451.7 1452.3 1453.6 1454.6 959.8 960.5 994.4 998.0 1015.7 4783.7 4827.4 4829.1 4834.7 4841.4 5692.9 5694.3 5698.6 5699.4 5710.8 4819.9 4823.2 4824.9 4827.0 4829.7 2851.2 2922.5 3045.9 3087.1 3087.1 5337.7 5417.9 5426.3 5430.5 5433.2 5926.5 5927.9 5931.6 5935.6 5941.1 5197.8 5238.8 5318.9 5410.6 5411.1 5739.5 5743.5 5757.1 5757.6 5767.1 5605.2 5633.5 5633.9 5634.9 5639.8 5288.6 5381.4 5484.0 5491.9 5497.8 4066.9 4077.7 4077.9 4079.0 4081.8 5756.4 5758.9 5764.3 5768.5 5769.8 5528.7 5532.3 5536.7 5543.3 5546.0 5409.1 5532.1 5536.1 5542.4 5542.8 5480.7 5509.4 5513.9 5514.6 5514.6 5682.9 5690.4 5694.2 5695.3 5696.3 5444.5 5521.6 5540.3 5549.5 5553.3 04:53:04 INFO - 2015-11-24 04:53:04,453 DEBUG : BROWSER_OUTPUT: 04:53:04 INFO - 2015-11-24 04:53:04,453 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12021.41 Median:518.41 stddev:13790.97 (2660.2%) stddev-sans-first:13803.38 04:53:04 INFO - 2015-11-24 04:53:04,455 DEBUG : BROWSER_OUTPUT: Values: 683.7 693.7 717.9 738.5 759.5 11294.3 11502.5 11565.2 11582.0 12819.5 13031.9 13223.4 13225.5 13255.1 13269.5 609.9 617.0 753.9 762.6 778.2 766.3 768.3 772.9 773.4 773.7 640.1 799.4 807.1 807.3 807.3 643.4 794.3 817.6 818.0 818.8 579.0 586.1 591.5 591.6 592.4 11394.8 11574.8 11639.6 11683.7 11689.9 10728.7 11202.3 11246.3 11468.5 11503.3 9028.0 9134.4 9143.8 9201.6 9314.8 3186.1 3192.7 3210.6 3216.4 3290.8 40327.6 40519.2 40840.0 41059.4 41147.2 9183.9 9220.4 9242.2 9582.3 9647.4 15884.4 15896.0 16655.6 16888.2 16889.4 6206.9 6239.4 6347.8 6388.2 6499.5 3433.5 3493.8 3608.2 3608.8 3736.8 2679.5 2710.1 2715.2 2717.2 2720.0 472.7 479.4 497.6 499.4 501.1 482.2 507.0 514.3 518.9 522.4 6988.0 7228.4 7299.5 7299.7 7437.1 418.4 517.9 529.7 548.9 552.3 3450.8 3544.8 3569.8 3570.2 3650.8 47779.0 48816.5 51576.5 53120.7 53580.7 43153.4 43176.4 43322.0 43617.0 45108.3 39355.4 39708.4 40332.4 40425.4 40562.0 7489.7 7533.0 7833.3 7839.0 7927.0 30730.7 31040.2 31408.7 31510.7 31957.8 37419.8 37433.0 37602.2 37889.0 37976.0 8986.1 9321.8 9329.9 9430.4 9533.8 10196.3 10475.3 10691.0 10758.3 10904.8 9482.6 9525.8 9596.6 9937.8 10450.8 9255.4 9322.5 9526.0 10008.7 10036.7 9471.5 9548.7 9624.0 9657.1 9912.3 8115.6 8205.3 8445.7 8577.7 8623.3 7529.2 7916.8 7943.0 7987.4 8127.8 04:53:04 INFO - 2015-11-24 04:53:04,455 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:53:04 INFO - 2015-11-24 04:53:04,455 DEBUG : BROWSER_OUTPUT: 04:53:05 INFO - 2015-11-24 04:53:05,245 INFO : Browser exited with error code: 0 04:53:05 INFO - 2015-11-24 04:53:05,271 INFO : Completed test dromaeo_css (00:18:38) 04:53:05 INFO - 2015-11-24 04:53:05,271 INFO : Starting test kraken 04:53:05 INFO - 2015-11-24 04:53:05,271 DEBUG : operating with platform_type : linux_ 04:53:05 INFO - 2015-11-24 04:53:05,271 INFO : Initialising browser for kraken test... 04:53:05 INFO - 2015-11-24 04:53:05,278 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptAheXv/profile http://localhost:49978/getInfo.html 04:53:09 INFO - 2015-11-24 04:53:09,354 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:53:09 INFO - 2015-11-24 04:53:09,354 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:53:09 INFO - 2015-11-24 04:53:09,354 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:53:09 INFO - 2015-11-24 04:53:09,354 DEBUG : BROWSER_OUTPUT: __metrics 04:53:09 INFO - 2015-11-24 04:53:09,504 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:10 INFO - 2015-11-24 04:53:10,797 INFO : Browser initialized. 04:53:10 INFO - 2015-11-24 04:53:10,798 INFO : Running cycle 1/1 for kraken test... 04:53:10 INFO - 2015-11-24 04:53:10,798 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptAheXv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:53:22 INFO - 2015-11-24 04:53:22,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 140513280 04:53:22 INFO - 2015-11-24 04:53:22,748 DEBUG : BROWSER_OUTPUT: 04:53:25 INFO - 2015-11-24 04:53:25,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49978/tests/kraken/driver.html?testName=audio-beat-detection) 04:53:25 INFO - 2015-11-24 04:53:25,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 178987008 04:53:25 INFO - 2015-11-24 04:53:25,968 DEBUG : BROWSER_OUTPUT: 04:53:28 INFO - 2015-11-24 04:53:28,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49978/tests/kraken/driver.html?testName=audio-dft) 04:53:29 INFO - 2015-11-24 04:53:29,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 169717760 04:53:29 INFO - 2015-11-24 04:53:29,316 DEBUG : BROWSER_OUTPUT: 04:53:32 INFO - 2015-11-24 04:53:32,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49978/tests/kraken/driver.html?testName=audio-fft) 04:53:32 INFO - 2015-11-24 04:53:32,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 154107904 04:53:32 INFO - 2015-11-24 04:53:32,885 DEBUG : BROWSER_OUTPUT: 04:53:34 INFO - 2015-11-24 04:53:34,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49978/tests/kraken/driver.html?testName=audio-oscillator) 04:53:35 INFO - 2015-11-24 04:53:35,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 155172864 04:53:35 INFO - 2015-11-24 04:53:35,485 DEBUG : BROWSER_OUTPUT: 04:53:37 INFO - 2015-11-24 04:53:37,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49978/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:53:38 INFO - 2015-11-24 04:53:38,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 157130752 04:53:38 INFO - 2015-11-24 04:53:38,303 DEBUG : BROWSER_OUTPUT: 04:53:41 INFO - 2015-11-24 04:53:41,289 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49978/tests/kraken/driver.html?testName=imaging-darkroom) 04:53:41 INFO - 2015-11-24 04:53:41,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 156495872 04:53:41 INFO - 2015-11-24 04:53:41,871 DEBUG : BROWSER_OUTPUT: 04:53:45 INFO - 2015-11-24 04:53:45,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49978/tests/kraken/driver.html?testName=imaging-desaturate) 04:53:45 INFO - 2015-11-24 04:53:45,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 156856320 04:53:45 INFO - 2015-11-24 04:53:45,821 DEBUG : BROWSER_OUTPUT: 04:53:48 INFO - 2015-11-24 04:53:48,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49978/tests/kraken/driver.html?testName=json-parse-financial) 04:53:49 INFO - 2015-11-24 04:53:49,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 157126656 04:53:49 INFO - 2015-11-24 04:53:49,227 DEBUG : BROWSER_OUTPUT: 04:53:51 INFO - 2015-11-24 04:53:51,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49978/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:53:51 INFO - 2015-11-24 04:53:51,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 166596608 04:53:51 INFO - 2015-11-24 04:53:51,578 DEBUG : BROWSER_OUTPUT: 04:53:53 INFO - 2015-11-24 04:53:53,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49978/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:53:54 INFO - 2015-11-24 04:53:54,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 164732928 04:53:54 INFO - 2015-11-24 04:53:54,043 DEBUG : BROWSER_OUTPUT: 04:53:56 INFO - 2015-11-24 04:53:56,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49978/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:53:56 INFO - 2015-11-24 04:53:56,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 170573824 04:53:56 INFO - 2015-11-24 04:53:56,984 DEBUG : BROWSER_OUTPUT: 04:53:59 INFO - 2015-11-24 04:53:59,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:54:00 INFO - 2015-11-24 04:54:00,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 177209344 04:54:00 INFO - 2015-11-24 04:54:00,151 DEBUG : BROWSER_OUTPUT: 04:54:02 INFO - 2015-11-24 04:54:02,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:54:03 INFO - 2015-11-24 04:54:03,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 176222208 04:54:03 INFO - 2015-11-24 04:54:03,319 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49978/tests/kraken/driver.html?testName=ai-astar) 04:54:05 INFO - 2015-11-24 04:54:05,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 235347968 04:54:05 INFO - 2015-11-24 04:54:05,338 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,338 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:54:05 INFO - 2015-11-24 04:54:05,338 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:54:05 INFO - 2015-11-24 04:54:05,338 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:54:05 INFO - 2015-11-24 04:54:05,338 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:54:05 INFO - 2015-11-24 04:54:05,339 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;115;109;113;115;113;103;112;112;109 04:54:05 INFO - 2015-11-24 04:54:05,339 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;139;167;164;148;153;157;138;173;141 04:54:05 INFO - 2015-11-24 04:54:05,339 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;160;160;163;163;163;162;169 04:54:05 INFO - 2015-11-24 04:54:05,339 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;92;93;72;71;71;118;87;72 04:54:05 INFO - 2015-11-24 04:54:05,339 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;141;94;95;94;128;94;95;128 04:54:05 INFO - 2015-11-24 04:54:05,339 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;110;110;109;110;110 04:54:05 INFO - 2015-11-24 04:54:05,339 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;147;146;146;146 04:54:05 INFO - 2015-11-24 04:54:05,340 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;95;96;96;96;95;96 04:54:05 INFO - 2015-11-24 04:54:05,340 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;73;72;73;71;72;72;69;70 04:54:05 INFO - 2015-11-24 04:54:05,340 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;68;73;69;69;69;70 04:54:05 INFO - 2015-11-24 04:54:05,340 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;93;85;83;90;82;83;84;82 04:54:05 INFO - 2015-11-24 04:54:05,340 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;125;128;134;130;127;124;121;130;129 04:54:05 INFO - 2015-11-24 04:54:05,340 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;144;140;136;147;148;147;149;154;137 04:54:05 INFO - 2015-11-24 04:54:05,340 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;69;70;71;70;68;68;69;69 04:54:05 INFO - 2015-11-24 04:54:05,340 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:54:05 INFO - 2015-11-24 04:54:05,341 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:54:05 INFO - 2015-11-24 04:54:05,341 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,982 04:54:05 INFO - 2015-11-24 04:54:05,341 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:54:05 INFO - 2015-11-24 04:54:05,341 DEBUG : BROWSER_OUTPUT: __startTimestamp1448369645336__endTimestamp 04:54:05 INFO - 2015-11-24 04:54:05,341 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,345 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:54:05 INFO - 2015-11-24 04:54:05,345 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:54:05 INFO - 2015-11-24 04:54:05,345 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,345 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:112.50 stddev:3.55 (3.2%) stddev-sans-first:3.77 04:54:05 INFO - 2015-11-24 04:54:05,345 DEBUG : BROWSER_OUTPUT: Values: 111.0 115.0 109.0 113.0 115.0 113.0 103.0 112.0 112.0 109.0 04:54:05 INFO - 2015-11-24 04:54:05,345 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,346 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:153.90 Median:158.00 stddev:12.25 (7.8%) stddev-sans-first:12.85 04:54:05 INFO - 2015-11-24 04:54:05,346 DEBUG : BROWSER_OUTPUT: Values: 159.0 139.0 167.0 164.0 148.0 153.0 157.0 138.0 173.0 141.0 04:54:05 INFO - 2015-11-24 04:54:05,346 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,347 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:2.59 (1.6%) stddev-sans-first:2.74 04:54:05 INFO - 2015-11-24 04:54:05,347 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 160.0 160.0 163.0 163.0 163.0 162.0 169.0 04:54:05 INFO - 2015-11-24 04:54:05,348 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,348 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.90 Median:72.00 stddev:15.65 (21.7%) stddev-sans-first:16.19 04:54:05 INFO - 2015-11-24 04:54:05,348 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 92.0 93.0 72.0 71.0 71.0 118.0 87.0 72.0 04:54:05 INFO - 2015-11-24 04:54:05,348 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,348 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.50 stddev:18.59 (19.7%) stddev-sans-first:19.29 04:54:05 INFO - 2015-11-24 04:54:05,348 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 141.0 94.0 95.0 94.0 128.0 94.0 95.0 128.0 04:54:05 INFO - 2015-11-24 04:54:05,349 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,349 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:54:05 INFO - 2015-11-24 04:54:05,349 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 110.0 110.0 109.0 110.0 110.0 04:54:05 INFO - 2015-11-24 04:54:05,349 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,349 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 04:54:05 INFO - 2015-11-24 04:54:05,349 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 04:54:05 INFO - 2015-11-24 04:54:05,349 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,349 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:54:05 INFO - 2015-11-24 04:54:05,349 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 04:54:05 INFO - 2015-11-24 04:54:05,349 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.70 Median:72.00 stddev:1.34 (1.9%) stddev-sans-first:1.33 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 72.0 73.0 71.0 72.0 72.0 69.0 70.0 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:1.66 (2.4%) stddev-sans-first:1.62 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 68.0 73.0 69.0 69.0 69.0 70.0 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:3.83 (4.6%) stddev-sans-first:3.82 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 93.0 85.0 83.0 90.0 82.0 83.0 84.0 82.0 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:128.50 stddev:3.71 (2.9%) stddev-sans-first:3.84 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 128.0 134.0 130.0 127.0 124.0 121.0 130.0 129.0 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.50 Median:147.00 stddev:5.64 (3.8%) stddev-sans-first:5.96 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: Values: 143.0 144.0 140.0 136.0 147.0 148.0 147.0 149.0 154.0 137.0 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: 04:54:05 INFO - 2015-11-24 04:54:05,350 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:0.95 (1.4%) stddev-sans-first:0.97 04:54:05 INFO - 2015-11-24 04:54:05,351 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 70.0 71.0 70.0 68.0 68.0 69.0 69.0 04:54:05 INFO - 2015-11-24 04:54:05,351 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:54:05 INFO - 2015-11-24 04:54:05,351 DEBUG : BROWSER_OUTPUT: 04:54:06 INFO - 2015-11-24 04:54:06,285 INFO : Browser exited with error code: 0 04:54:06 INFO - 2015-11-24 04:54:06,334 INFO : Completed test kraken (00:01:01) 04:54:06 INFO - 2015-11-24 04:54:06,334 INFO : Starting test v8_7 04:54:06 INFO - 2015-11-24 04:54:06,334 DEBUG : operating with platform_type : linux_ 04:54:06 INFO - 2015-11-24 04:54:06,335 INFO : Initialising browser for v8_7 test... 04:54:06 INFO - 2015-11-24 04:54:06,341 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphc_eSQ/profile http://localhost:49978/getInfo.html 04:54:10 INFO - 2015-11-24 04:54:10,260 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:54:10 INFO - 2015-11-24 04:54:10,260 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:54:10 INFO - 2015-11-24 04:54:10,260 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:54:10 INFO - 2015-11-24 04:54:10,260 DEBUG : BROWSER_OUTPUT: __metrics 04:54:10 INFO - 2015-11-24 04:54:10,397 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:54:11 INFO - 2015-11-24 04:54:11,710 INFO : Browser initialized. 04:54:11 INFO - 2015-11-24 04:54:11,710 INFO : Running cycle 1/1 for v8_7 test... 04:54:11 INFO - 2015-11-24 04:54:11,711 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphc_eSQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:54:23 INFO - 2015-11-24 04:54:23,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 140484608 04:54:23 INFO - 2015-11-24 04:54:23,608 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49978/tests/v8_7/run.html (next: http://localhost:49978/tests/v8_7/run.html) 04:54:45 INFO - 2015-11-24 04:54:45,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 458768384 04:54:45 INFO - 2015-11-24 04:54:45,389 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,389 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:54:45 INFO - 2015-11-24 04:54:45,390 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:54:45 INFO - 2015-11-24 04:54:45,390 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:54:45 INFO - 2015-11-24 04:54:45,390 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:54:45 INFO - 2015-11-24 04:54:45,390 DEBUG : BROWSER_OUTPUT: |0;Richards;185.70102135561746 04:54:45 INFO - 2015-11-24 04:54:45,390 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.9508319312021 04:54:45 INFO - 2015-11-24 04:54:45,390 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 04:54:45 INFO - 2015-11-24 04:54:45,390 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4995.024875621891 04:54:45 INFO - 2015-11-24 04:54:45,390 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1978.2608695652175 04:54:45 INFO - 2015-11-24 04:54:45,391 DEBUG : BROWSER_OUTPUT: |5;Earley;796.1783439490446 04:54:45 INFO - 2015-11-24 04:54:45,391 DEBUG : BROWSER_OUTPUT: |6;Boyer;12292.682926829268 04:54:45 INFO - 2015-11-24 04:54:45,391 DEBUG : BROWSER_OUTPUT: |7;RegExp;26921.052631578947 04:54:45 INFO - 2015-11-24 04:54:45,391 DEBUG : BROWSER_OUTPUT: |8;Splay;606.4981949458484 04:54:45 INFO - 2015-11-24 04:54:45,391 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:54:45 INFO - 2015-11-24 04:54:45,391 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:54:45 INFO - 2015-11-24 04:54:45,391 DEBUG : BROWSER_OUTPUT: __startTimestamp1448369685383__endTimestamp 04:54:45 INFO - 2015-11-24 04:54:45,392 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,392 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:54:45 INFO - 2015-11-24 04:54:45,392 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:54:45 INFO - 2015-11-24 04:54:45,392 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,392 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:185.70 Median:185.70 stddev:0.00 (0.0%) 04:54:45 INFO - 2015-11-24 04:54:45,392 DEBUG : BROWSER_OUTPUT: Values: 185.7 04:54:45 INFO - 2015-11-24 04:54:45,392 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,392 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.95 Median:186.95 stddev:0.00 (0.0%) 04:54:45 INFO - 2015-11-24 04:54:45,393 DEBUG : BROWSER_OUTPUT: Values: 187.0 04:54:45 INFO - 2015-11-24 04:54:45,393 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,393 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 04:54:45 INFO - 2015-11-24 04:54:45,393 DEBUG : BROWSER_OUTPUT: Values: 279.2 04:54:45 INFO - 2015-11-24 04:54:45,393 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,393 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4995.02 Median:4995.02 stddev:0.00 (0.0%) 04:54:45 INFO - 2015-11-24 04:54:45,393 DEBUG : BROWSER_OUTPUT: Values: 4995.0 04:54:45 INFO - 2015-11-24 04:54:45,394 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,394 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 04:54:45 INFO - 2015-11-24 04:54:45,394 DEBUG : BROWSER_OUTPUT: Values: 1978.3 04:54:45 INFO - 2015-11-24 04:54:45,394 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,394 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 04:54:45 INFO - 2015-11-24 04:54:45,394 DEBUG : BROWSER_OUTPUT: Values: 796.2 04:54:45 INFO - 2015-11-24 04:54:45,394 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,394 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 04:54:45 INFO - 2015-11-24 04:54:45,395 DEBUG : BROWSER_OUTPUT: Values: 12292.7 04:54:45 INFO - 2015-11-24 04:54:45,395 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,395 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26921.05 Median:26921.05 stddev:0.00 (0.0%) 04:54:45 INFO - 2015-11-24 04:54:45,395 DEBUG : BROWSER_OUTPUT: Values: 26921.1 04:54:45 INFO - 2015-11-24 04:54:45,395 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,395 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:606.50 Median:606.50 stddev:0.00 (0.0%) 04:54:45 INFO - 2015-11-24 04:54:45,395 DEBUG : BROWSER_OUTPUT: Values: 606.5 04:54:45 INFO - 2015-11-24 04:54:45,395 DEBUG : BROWSER_OUTPUT: 04:54:45 INFO - 2015-11-24 04:54:45,395 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:54:45 INFO - 2015-11-24 04:54:45,395 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:54:45 INFO - 2015-11-24 04:54:45,395 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:54:45 INFO - 2015-11-24 04:54:45,395 DEBUG : BROWSER_OUTPUT: 04:54:46 INFO - 2015-11-24 04:54:46,281 INFO : Browser exited with error code: 0 04:54:46 INFO - 2015-11-24 04:54:46,298 INFO : Completed test v8_7 (00:00:39) 04:54:46 INFO - 2015-11-24 04:54:46,308 INFO : Completed test suite (00:20:19) 04:54:46 INFO - 2015-11-24 04:54:46,309 DEBUG : Working with test: dromaeo_css 04:54:46 INFO - 2015-11-24 04:54:46,309 DEBUG : Generating results file: dromaeo_css 04:54:46 INFO - 2015-11-24 04:54:46,310 DEBUG : Working with test: kraken 04:54:46 INFO - 2015-11-24 04:54:46,310 DEBUG : Generating results file: kraken 04:54:46 INFO - 2015-11-24 04:54:46,310 INFO : javascript benchmark 04:54:46 INFO - 2015-11-24 04:54:46,310 DEBUG : Working with test: v8_7 04:54:46 INFO - 2015-11-24 04:54:46,310 DEBUG : Generating results file: v8_7 04:54:46 INFO - 2015-11-24 04:54:46,311 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:54:46 INFO - 2015-11-24 04:54:46,366 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 04:54:46 INFO - 2015-11-24 04:54:46,366 DEBUG : process_Request line: dromaeo_css 6310.27 graph.html#tests=[[72,203,35]] 04:54:46 INFO - 2015-11-24 04:54:46,366 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:54:46 INFO - 2015-11-24 04:54:46,395 DEBUG : process_Request line: kraken 1533.00 graph.html#tests=[[232,203,35]] 04:54:46 INFO - 2015-11-24 04:54:46,395 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:54:46 INFO - 2015-11-24 04:54:46,425 DEBUG : process_Request line: v8_7 19612.37 graph.html#tests=[[230,203,35]] 04:54:46 INFO - 2015-11-24 04:54:46,427 INFO : javascript benchmark 04:54:46 INFO - 2015-11-24 04:54:46,430 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2511.6609257750206, 2626.1596289187455, 2637.3670319123403, 2642.6432431621724, 2648.9205323840292, 4369.235383807837, 4517.367568540403, 4530.7281563106235, 4531.977340113295, 4549.590536851682, 4429.46846378435, 4435.379046933432, 4505.639548836093, 4511.458624965009, 4556.794944227509, 4152.77159756214, 4154.813033413504, 4185.434966279559, 4310.137972405516, 4352.455943007124, 4300.870973870773, 4364.083542456088, 4370.2133615949115, 4372.540883207265, 4420.961074147573, 4100.79496025199, 4169.624733773944, 4206.936895946563, 4216.388623649585, 4287.399764033038, 4293.699441039129, 4302.827886884521, 4308.418363520916, 4316.0, 4345.239583072981, 4283.336082907154, 4286.464191976003, 4297.892552686208, 4309.439772829513, 4311.331743579719, 4323.632491238249, 4450.554944505556, 4465.062336909253, 4491.30384790358, 4592.885177870547, 4815.277708343741, 4831.444383895827, 4922.507749225085, 4932.2108462646165, 4972.179590367621, 4931.876703082416, 4933.432655244657, 4937.35814344133, 4950.331705219785, 4959.355283813081, 4380.452443444569, 4481.910361792746, 4484.775761211927, 4486.685931984795, 4544.88637784058, 5000.6999580024585, 5002.874928126753, 5004.2493625956395, 5031.798728050837, 5081.5426611605135, 4799.304100905419, 4804.855854324376, 4804.942912559231, 4812.614990800727, 4830.275458681155, 4644.86065418038, 4755.239161734106, 4764.404449443819, 4771.165046116916, 4911.68074075184, 4907.018596280758, 4960.404751429852, 4964.553190212898, 4967.652264341534, 4968.1554135797005, 4947.134251506044, 4954.0, 4955.752212389366, 4955.90088198234, 4965.379327584052, 3914.8434062637743, 3962.980185099114, 4004.3392840181627, 4009.1781184857036, 4187.078842654611, 3534.1164708822794, 3596.7662101963288, 3639.927201455956, 3644.3986742187244, 3679.098620837858, 4312.310030395121, 4320.805563749639, 4324.891877703082, 4333.501647310537, 4360.018995726, 4755.500672429345, 4972.276873546749, 4989.426215985208, 4989.451160372356, 4991.600671946236, 4147.087640719037, 4173.7078404512, 4200.957990420118, 4244.490661120685, 4294.184105020036, 4313.158934007838, 4341.34879768031, 4343.4353534041, 4382.364557139197, 4407.933880991788, 4457.086297309109, 4670.813167473263, 4674.447419960922, 4676.368690226844, 4680.485146633868, 4821.710697358169, 4908.92636610444, 4947.406311242674, 4949.010197960494, 4959.429665588359, 4618.445786505641, 4677.929831052469, 4685.929711054405, 4690.648201384842, 4734.952650473451, 4720.480747117883, 4857.222844344888, 4876.024795041077, 4877.268409738567, 4931.16170251051, 4840.1287768200655, 4911.189653707098, 4911.926321105115, 4933.605311574994, 4978.502149784992, 4805.303231031551, 4833.130036593447, 4838.758062096951, 4838.951610483991, 4871.269309603588, 4626.6530010250035, 4798.880027999328, 4821.614270858253, 4826.686265392738, 4871.707697538159, 4572.702774319659, 4581.0, 4620.306953956799, 4649.395578574764, 4656.0, 4819.879503012453, 4838.806447742051, 4854.344663470528, 4854.344663470528, 4889.853304400874, 4720.834770783006, 4735.83424580138, 4742.454617718869, 4745.264484004984, 4788.3056956741775], "unit": "ms", "name": "dojo.html", "value": 4504.065318250445}, {"lowerIsBetter": false, "replicates": [564.4496615799596, 573.0458786121108, 574.8591595059208, 578.5747475605432, 580.6487075319432, 26272.868635656818, 26789.0, 37557.81221093897, 38394.424083638696, 38425.61574384255, 40411.0, 40877.795611021975, 40894.795526022404, 41010.38484422729, 41045.58954410455, 6894.689738961759, 7736.226377362275, 7744.419168562352, 7859.214078592152, 7920.049594048723, 6947.0, 10010.849837252446, 10015.949920250388, 10244.129249013842, 10255.538500767447, 9792.657256996006, 9901.306908516406, 9927.106560409562, 9928.255380846465, 9955.253355998293, 6897.689603967833, 7091.219965803757, 9780.462074585896, 9882.258830587698, 10095.899041009568, 9677.322587418883, 9885.604575816958, 9896.90103098967, 9906.801863962752, 10017.949910250401, 37514.24971500582, 37940.43089353662, 37940.62059379398, 37966.24067518634, 38010.80994595037, 2839.2617919340914, 3001.639803223605, 3026.4854974654363, 3391.0, 3412.709919656832, 26965.730342696716, 27561.173164805088, 27785.722142778515, 27900.302492437648, 27942.947068668225, 3292.111129994912, 3302.9174270643184, 3315.900522984314, 3343.0806528204694, 3456.5679290088738, 221170.0, 221175.0, 221800.6729899053, 221909.0, 222742.0, 55211.0, 55611.72194139003, 55622.72188639031, 55649.0, 55656.87774344819, 48590.757046214545, 49343.50656493461, 65061.0, 66407.69126932934, 66554.67394619335, 12654.304013279174, 12751.42618582166, 12756.234625922474, 12778.872211277954, 12826.743465130645, 10354.689359319233, 10400.375977441377, 10423.218258630633, 10464.686059418229, 10534.947325263325, 18856.151473183465, 19064.14211360492, 19082.94672852337, 19113.808861911482, 19193.712094318595, 7285.198628150899, 7503.084822672465, 7557.735479258199, 7638.121616014229, 7651.808704782425, 822.9012518497699, 902.2015516268019, 926.1294383279695, 984.4044353166374, 990.0990099009866, 26226.737732622812, 26424.207273781816, 26438.339041524116, 26444.47111057768, 29769.0, 903.4037535226851, 921.8386782313069, 939.2110627073291, 954.2413781043948, 996.2776986684596, 15192.696146077016, 16126.838731612534, 16192.676146477004, 16209.0, 16251.0, 330363.0, 336984.0, 337587.0, 337916.0, 338148.0, 48109.5189048112, 48579.757101214265, 48621.270680939815, 48644.0, 48650.756746216044, 1165.6677846813618, 1195.6711904226233, 1206.0652993929775, 1208.371646743706, 1208.86098098718, 25977.35056623524, 26793.732062679122, 27586.89652413881, 28032.0, 30060.398792024476, 41370.379444308965, 42012.0, 42033.36949945692, 42590.36114458224, 42753.35869961891, 241917.0, 244710.0, 245435.0, 245890.0, 246328.0, 23568.52862942766, 26020.479590407707, 27979.720202798526, 28082.0, 29041.128766137048, 33189.0, 33426.16434589155, 44485.555144449434, 45974.54025459703, 45982.310265345375, 33668.83165584156, 34030.149246269044, 34040.0, 34103.0, 34612.30775384428, 28439.411234006337, 34436.48345274773, 34532.136696582784, 34579.308413832085, 34773.82613086919, 27451.450970980866, 35217.295654087284, 35230.47154292739, 35287.64712352843, 35309.29381412409, 25914.87042564775, 26654.733452665227, 29093.41813163767, 29699.406011880073, 29844.253893651963, 24782.752172478045, 25643.0, 25759.613605795552, 26056.0, 26432.471350573265], "unit": "ms", "name": "ext.html", "value": 17423.379976798264}, {"lowerIsBetter": false, "replicates": [331.08785296508114, 332.9550510681057, 334.52831507574325, 334.9095744149079, 339.526360726786, 12355.382230888465, 12727.490900363997, 14715.779263311046, 15113.244337783108, 15383.69232615347, 11732.882671173285, 14150.15099094055, 14767.483138090169, 15371.692566148671, 15374.538763837103, 4409.228385032607, 5447.1829225616175, 5511.200875872996, 5532.059549876531, 5600.411956744524, 5317.494837990384, 5336.466353364672, 5363.731813409334, 5369.24830523727, 5374.381946076192, 5198.324217851674, 5264.684118952856, 5286.814961476349, 5438.320209973754, 5542.4457554244655, 5535.114381698929, 5548.58385621078, 5552.666839989613, 5575.442455754433, 5586.692731899744, 5385.35375754908, 5398.703071331075, 5768.105943578752, 5970.910436343458, 5980.28236611605, 20535.794642053537, 21035.158593656237, 21301.573968520544, 21608.675869861963, 21643.45891352713, 1747.3971479839436, 1871.737956686065, 1911.8852868827914, 2014.1238561225914, 2026.3414390323203, 10857.891421085767, 12279.57021504252, 12478.0, 13246.337683115806, 13956.441742330295, 1716.2019660857761, 1739.9130043497773, 1757.5869670627392, 1846.9168887400099, 1859.8168060533626, 59009.40990590125, 62980.0, 64045.67977160131, 65171.348286517, 66297.3370266296, 15440.613984650248, 15461.613459663598, 15492.51418430844, 15496.457623983106, 15496.767548486781, 18493.445196644123, 18793.718094228323, 20433.48916277105, 22965.54068918646, 22975.655365169536, 8452.830943381221, 8523.573821309034, 8559.786005349792, 8612.224899759052, 8639.95680021596, 7044.718211271595, 7051.330123638246, 7070.717171313193, 7099.432045436352, 7171.1394632644415, 7569.432292578079, 7586.431017673696, 7618.390528757686, 7644.464887457824, 7702.0, 2900.8694608742658, 2970.5395663672166, 3015.4873671475902, 3030.863611137504, 3059.0785799561368, 827.0945449490641, 837.9287760540301, 847.2459511035183, 884.5090974509209, 928.5078908178676, 15450.150241736588, 15825.920870395805, 15912.52262432129, 16160.595985100232, 16228.0, 806.435495153395, 831.580052073711, 844.9915500844913, 854.1629203380721, 863.4560227056913, 7731.458797884206, 8836.160564746338, 9189.954050229706, 9207.953960230156, 9339.813203735886, 312888.0, 449181.0, 452469.0, 456505.0, 458219.0, 61579.38420615826, 62008.0, 62279.6886015567, 62969.37030629726, 64029.67985160137, 1018.0532105142289, 1068.5725709716176, 1071.394662015974, 1073.4042606353548, 1088.7223757941833, 8546.78633034179, 8951.955240223757, 9244.537773111182, 9446.433214007182, 13691.110077844909, 31007.84496077505, 31275.374492509567, 31950.68049319477, 33328.1667958303, 33470.4979425304, 46268.305975411065, 46828.7658561705, 47060.7646961763, 47541.76229118832, 47759.52240477551, 13584.25286609246, 13758.793618095537, 13765.242911639956, 13778.517751878637, 14191.0, 16810.915945420686, 17001.744973825156, 17010.48968530946, 17440.563985900455, 17597.032163230633, 14439.711205776035, 14462.421503140178, 14738.11571305725, 14802.185879776716, 14824.481143159937, 13953.720925581634, 14463.92768036153, 14490.85509144895, 14588.854111459174, 15116.54650360491, 14821.703565928836, 14879.702405952037, 15031.699366012399, 15315.004524706304, 15340.693186135992, 13499.122557033761, 13508.662283442993, 13708.86291137076, 13816.309184540934, 13837.308134593432, 13487.59537213846, 13978.301084945915, 14448.133112013313, 14786.0, 14850.108993460426], "unit": "ms", "name": "jquery.html", "value": 9224.519423024674}, {"lowerIsBetter": false, "replicates": [1184.2420850655587, 1568.3804897065656, 1604.0856711674344, 1647.5551601067716, 1661.1279078483794, 5634.295713035871, 6290.0, 6440.581362211453, 6440.838979025527, 6453.838654033651, 6447.097406363101, 6608.405243528082, 6627.436667883236, 6683.966580167104, 6719.462443004561, 1679.3030892179793, 1732.861371090316, 1735.3232239426634, 2009.4172689919906, 2032.6442872497328, 2031.055559164988, 2080.2927004818434, 2081.7918208179212, 2082.5834833033377, 2082.635538780715, 1990.9800901991011, 2009.2164056018164, 2017.4855411869953, 2037.9694304585444, 2038.6534289170802, 2007.7389939307795, 2054.897255137237, 2082.531430428157, 2087.7390326209224, 2088.2377932054765, 2008.6183625111182, 2025.382258411184, 2025.6151331247015, 2027.6654352031896, 2028.4421784009514, 6577.112089867855, 6668.799936001928, 6697.19633643961, 6745.258021617618, 6753.088333075021, 3781.6596506314563, 3866.516685414323, 3867.284552357795, 3874.9612503874882, 3877.3602355611292, 2596.532624127656, 2611.5299246135687, 2611.8041146913865, 2626.5534859074005, 2629.3426643339167, 759.3355813663045, 910.8633704944245, 912.9041450647719, 927.9953600232024, 944.6929747831913, 8927.776805579848, 9006.144416280444, 9019.729408117766, 9022.639094436281, 9026.819463610691, 3802.961970380316, 3808.333541630204, 3864.9613503864603, 3879.282332768447, 3882.786446745456, 7740.4194685398825, 7744.883826742604, 7746.961265193638, 7756.457048006585, 7757.961210194026, 4007.338789099824, 4012.077222238843, 4079.89800254996, 4084.0606660468256, 4090.8159132839096, 3664.523611930432, 3668.926621467556, 3670.0457880951144, 3670.376036073874, 3687.022938921188, 3316.403047451434, 3319.137024373632, 3331.900042998714, 3365.6634336566635, 3368.79787212768, 1037.123630532199, 1040.245821779219, 1047.3768107975743, 1051.2746205118444, 1051.2851261142343, 1075.5536452372335, 1091.317926296065, 1102.5699977008974, 1115.743379022813, 1118.1334465789078, 6458.257300410419, 6494.253160886558, 6514.250861150934, 6514.250861151028, 6515.543911926215, 424.7897290841053, 425.53829095431183, 436.1342734671674, 436.5874248834884, 438.51982079622763, 4985.576226020757, 5022.949770502321, 5078.771455284521, 5114.41184263807, 5114.616403769732, 6948.583085014814, 7402.555846649218, 7800.258975397328, 7815.374770018499, 7972.043354797462, 7724.0731112266885, 7731.304182623591, 7748.728794492165, 7754.340881025176, 7827.6477558510005, 5948.643081415129, 6033.306169790442, 6075.0, 6075.875962946958, 6089.756409743649, 5811.738471768696, 5940.138679891478, 5943.732532035982, 5943.940560594338, 5948.196993405835, 6376.553641245068, 6832.111825462658, 6860.3139686031, 6890.0, 6903.585784852925, 6832.111825462658, 7040.57756534589, 7138.428925685829, 7140.214576396696, 7158.713651453883, 5830.883382332415, 5924.6149000314845, 5928.288605367384, 5929.080992446177, 5933.575941773857, 6378.808635740936, 6423.582467139621, 6423.614583125028, 6496.902546461902, 6498.057781621733, 6104.053871649901, 6112.541559382975, 6139.109829074849, 6204.5967012144065, 6313.3686631336495, 5912.320083190488, 6015.578909476295, 6017.699115044143, 6018.668973206516, 6126.111713801563, 6008.54935879802, 6069.180660610761, 6070.848228794315, 6095.817125486243, 6103.908441373294, 5644.576656750843, 5681.375048744718, 5699.943000569941, 5700.828975130753, 5709.486146246858, 5772.191893135048, 5823.592348535732, 5840.1531777892815, 5844.853878653068, 5847.678377689268], "unit": "ms", "name": "mootools.html", "value": 3803.2939356119564}, {"lowerIsBetter": false, "replicates": [290.3612053482339, 299.72874548533576, 305.54016205610566, 316.0691762758677, 316.9017604542592, 5253.658512196705, 5311.336082989622, 5320.866978325544, 5330.733463326827, 5350.625456218061, 5230.189320655295, 5231.163013917774, 5232.686038837673, 5242.475752424755, 5248.002879452902, 3874.8256328465145, 4127.9174416511805, 4161.313383291753, 4171.0, 4180.811863466151, 3934.154156856275, 3982.183652351261, 4042.7776472294013, 4049.858254961077, 4058.6144316289906, 3986.9800650996704, 4041.625847211962, 4051.0, 4053.4730485036903, 4059.5940405959464, 3899.941500877489, 3943.7633741975287, 3977.105151340954, 4052.392141178832, 4062.857799976987, 3525.2773181497732, 3526.3299973005046, 3527.224010717638, 3528.3648943190215, 3543.8936831895085, 5032.4212715537815, 5037.942032173248, 5051.166557518042, 5052.216906379517, 5071.366079240095, 4578.542145785428, 4581.0, 4581.931271030937, 4583.610393116589, 4588.793504292282, 5332.413434522199, 5470.91793623096, 5474.069408200576, 5475.945240547583, 5488.9725551371985, 3808.8095595220407, 3851.4030325299623, 3851.6340947609933, 3857.5756666766633, 3858.3247931612136, 5723.856903577403, 5777.0, 5866.296044474648, 5867.207926929896, 5873.911891321633, 3894.889956362423, 3899.29812633723, 3900.7464514806447, 3902.8829135125993, 3908.843646254118, 3843.423486477051, 3946.940795888064, 3959.6238357356006, 3964.5837187095517, 3969.821358038895, 4554.157480866051, 4554.180247555406, 4554.817807287738, 4562.201614717477, 4562.977185114053, 5494.670319780826, 5498.3127109111365, 5506.229127922094, 5506.449355064542, 5507.256520369779, 1419.6876687128815, 1451.7241724072392, 1452.3174108169144, 1453.6075259679826, 1454.614527150306, 959.836827739286, 960.4669408478222, 994.3884511025811, 998.0269237493386, 1015.7308313296983, 4783.689060211075, 4827.372441582572, 4829.106615276115, 4834.734089625104, 4841.419029716457, 5692.861427714391, 5694.288213973254, 5698.601097923189, 5699.401562835926, 5710.8001219957105, 4819.903601927942, 4823.1800593899125, 4824.890275236715, 4827.0, 4829.6860704054825, 2851.21591562322, 2922.503174460347, 3045.9238519037203, 3087.0893086539527, 3087.1047396255285, 5337.653052551572, 5417.891642167135, 5426.321709786277, 5430.5384042356845, 5433.239346491494, 5926.496247818897, 5927.851803704942, 5931.58478906481, 5935.554833387427, 5941.138534912414, 5197.8440646780655, 5238.790448382022, 5318.946810531846, 5410.621256512007, 5411.080116380146, 5739.483446489836, 5743.540516758733, 5757.050086735641, 5757.596968212352, 5767.077267637158, 5605.215269862304, 5633.521150702236, 5633.915491267552, 5634.943650563442, 5639.802606908738, 5288.629795914249, 5381.354237491526, 5484.0, 5491.890162196813, 5497.752601132878, 4066.898327541835, 4077.7145599808914, 4077.857274995361, 4079.0, 4081.7755023472805, 5756.395578464201, 5758.942410575841, 5764.279465066867, 5768.50967667753, 5769.769209231584, 5528.7235638218735, 5532.30846144232, 5536.695481748381, 5543.279373681396, 5545.973994810812, 5409.0804563223555, 5532.1425179097305, 5536.058869992031, 5542.445755424425, 5542.7782888684005, 5480.72596370172, 5509.393966663744, 5513.917291240715, 5514.558835293086, 5514.558835293247, 5682.886342273214, 5690.430956904276, 5694.231278777478, 5695.316562012419, 5696.344920334214, 5444.482774136451, 5521.641093328921, 5540.252065971043, 5549.500544950974, 5553.305836770403], "unit": "ms", "name": "prototype.html", "value": 4153.590582995681}, {"lowerIsBetter": false, "replicates": [683.6923384476987, 693.6601065477918, 717.946154038447, 738.5052015149856, 759.513911096898, 11294.265872718268, 11502.482388292527, 11565.190436669436, 11582.0, 12819.487220511191, 13031.934840325808, 13223.404946777395, 13225.470981160766, 13255.072144949832, 13269.535566255183, 609.9176611157503, 617.0066193428598, 753.8643044252033, 762.5805806806235, 778.2217782217782, 766.333290037668, 768.2854944901239, 772.9265719756643, 773.4353921637208, 773.686656903952, 640.0974625777654, 799.4284086877881, 807.144426907477, 807.29765104359, 807.3379828540599, 643.4305639509045, 794.3049831397527, 817.6034623207739, 818.0428898189133, 818.8034871630825, 578.9594728369016, 586.1354502109397, 591.5297338615811, 591.6361437715774, 592.4401440638599, 11394.829077563843, 11574.826377604342, 11639.592614258545, 11683.7079073023, 11689.883101168965, 10728.678139655824, 11202.327860328325, 11246.325220486715, 11468.541258349656, 11503.309801411942, 9028.0, 9134.406263592846, 9143.77140571491, 9201.631934722604, 9314.767130821716, 3186.0769820276337, 3192.696693814084, 3210.5665735125694, 3216.437123503401, 3290.7696461247483, 40327.59672403268, 40519.189616207805, 40840.0, 41059.38410923839, 41147.177056459004, 9183.862242066374, 9220.354575179806, 9242.214411775074, 9582.28132890036, 9647.372920760128, 15884.364625414853, 15896.0, 16655.583610409838, 16888.15559222034, 16889.408870689465, 6206.937930620727, 6239.376062393724, 6347.841303967345, 6388.169537960129, 6499.512536559682, 3433.484977253432, 3493.8427770750377, 3608.1701208721615, 3608.783472991629, 3736.794476303775, 2679.4775018871524, 2710.0785732850927, 2715.1718725788824, 2717.184844546628, 2720.047983205902, 472.6974736168855, 479.3576607346173, 497.59197458084026, 499.4356377293635, 501.0830180769184, 482.16103979076854, 506.97337890771485, 514.3236643813448, 518.902521167735, 522.4435975685958, 6987.965060174768, 7228.385587225145, 7299.5255308404785, 7299.744508942268, 7437.107547094275, 418.44764910318696, 517.9197224430219, 529.7430746088144, 548.934127904654, 552.3234038303127, 3450.7929524228625, 3544.8404821783083, 3569.803660798681, 3570.1610121621397, 3650.762700424464, 47779.0, 48816.511834881196, 51576.48423515792, 53120.734396327774, 53580.73209633927, 43153.35269970953, 43176.352354714705, 43322.0, 43617.0, 45108.3233751494, 39355.40966885499, 39708.40437393441, 40332.39501407481, 40425.39361909574, 40562.0, 7489.66296516669, 7532.962335188289, 7833.280971829593, 7839.0, 7927.0, 30730.692693072782, 31040.22399440032, 31408.685913140576, 31510.68489315169, 31957.840210798797, 37419.81290093532, 37433.0, 37602.24795504129, 37888.968882489884, 37976.0, 8986.14631609996, 9321.766955826159, 9329.860052099088, 9430.434173949585, 9533.761655958657, 10196.3372380795, 10475.319104258198, 10691.037806597444, 10758.300710453796, 10904.836427453753, 9482.57328420209, 9525.809483810424, 9596.616135354787, 9937.751556210864, 10450.843237351597, 9255.444673319622, 9322.533873306444, 9526.0, 10008.698869146965, 10036.698899033041, 9471.526423678652, 9548.713538593853, 9623.951880240555, 9657.082577155159, 9912.256580756328, 8115.634796434057, 8205.261526462647, 8445.746627601182, 8577.742667719978, 8623.310135189044, 7529.209433009455, 7916.762497125095, 7943.0, 7987.361011119213, 8127.75616731499], "unit": "ms", "name": "yui.html", "value": 5520.400946531644}], "name": "dromaeo_css", "value": 6310.270668226025}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 109.0, 113.0, 115.0, 113.0, 103.0, 112.0, 112.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [159.0, 139.0, 167.0, 164.0, 148.0, 153.0, 157.0, 138.0, 173.0, 141.0], "unit": "ms", "name": "audio-beat-detection", "value": 153.9}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 160.0, 160.0, 163.0, 163.0, 163.0, 162.0, 169.0], "unit": "ms", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 92.0, 93.0, 72.0, 71.0, 71.0, 118.0, 87.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 141.0, 94.0, 95.0, 94.0, 128.0, 94.0, 95.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 72.0, 73.0, 71.0, 72.0, 72.0, 69.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 71.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 73.0, 69.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 93.0, 85.0, 83.0, 90.0, 82.0, 83.0, 84.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [125.0, 125.0, 128.0, 134.0, 130.0, 127.0, 124.0, 121.0, 130.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.3}, {"lowerIsBetter": true, "replicates": [143.0, 144.0, 140.0, 136.0, 147.0, 148.0, 147.0, 149.0, 154.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.5}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 70.0, 71.0, 70.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1533.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [185.70102135561746], "unit": "score", "name": "Richards", "value": 190.10127000000003}, {"lowerIsBetter": false, "replicates": [186.9508319312021], "unit": "score", "name": "DeltaBlue", "value": 353.66518199999996}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [4995.024875621891], "unit": "score", "name": "Decrypt", "value": 53.289224103585696}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [26921.052631578947], "unit": "score", "name": "RegExp", "value": 33.83913000977518}, {"lowerIsBetter": false, "replicates": [606.4981949458484], "unit": "score", "name": "Splay", "value": 134.36313690476194}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19612.37382053682}]} 04:54:46 INFO - RETURN: dromaeo_css: 6310.27 04:54:46 INFO - RETURN: kraken: 1533.00 04:54:46 INFO - RETURN: v8_7: 19612.37 04:54:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19612.37"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1533.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6310.27"}}} 04:54:46 INFO - Return code: 0 04:54:46 INFO - # TBPL SUCCESS # 04:54:46 INFO - Running post-action listener: _resource_record_post_action 04:54:46 INFO - Running post-run listener: _resource_record_post_run 04:54:47 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 10436608; Write bytes: 396443648; Read time: 3964; Write time: 349488 04:54:47 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 2961408; Read time: 0; Write time: 236 04:54:47 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8065024; Write bytes: 393482240; Read time: 3128; Write time: 349252 04:54:47 INFO - Running post-run listener: _upload_blobber_files 04:54:47 INFO - Blob upload gear active. 04:54:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:54:47 INFO - Copying logs to upload dir... 04:54:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.329788 ========= master_lag: -0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-24 04:54:47.578666) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 04:54:47.581983) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009804 build_url: 'https://queue.taskcluster.net/v1/task/9dw5Bi5cQCG2OlgQGg2Z5Q/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-24 04:54:47.634566) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:54:47.635055) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1448367910.991650-1131063602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:54:47.685380) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 04:54:47.685712) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 04:54:47.686053) ========= ========= Total master_lag: 0.03 =========