builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1447952977.78 results: success (0) buildid: 20151119080012 builduid: 0ffbdb19c32448e49648de6c708daaf5 revision: 8703ad09f2074b06d8e455e992c5f5a4c3b4e1b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:37.784952) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:37.785466) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:37.785805) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.003611 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:37.800796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:37.801115) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:37.809700) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:37.809979) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003731 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:37.857065) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:37.857359) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:37.857704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:37.858028) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 09:09:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-11-19 09:09:38 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170460 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:38.040973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:38.041350) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018500 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:38.090910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:38.091327) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 8703ad09f2074b06d8e455e992c5f5a4c3b4e1b3 --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 8703ad09f2074b06d8e455e992c5f5a4c3b4e1b3 --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=a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 09:09:38,210 truncating revision to first 12 chars 2015-11-19 09:09:38,210 Setting DEBUG logging. 2015-11-19 09:09:38,210 attempt 1/10 2015-11-19 09:09:38,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/8703ad09f207?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 09:09:38,443 unpacking tar archive at: b2g-inbound-8703ad09f207/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516886 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:38.620965) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:38.621301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:38.630708) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:38.630973) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 09:09:38.631368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-19 09:09:38.631645) ========= /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=a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:09:38 INFO - MultiFileLogger online at 20151119 09:09:38 in /builds/slave/test 09:09:38 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 09:09:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:09:38 INFO - {'append_to_log': False, 09:09:38 INFO - 'base_work_dir': '/builds/slave/test', 09:09:38 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 09:09:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:09:38 INFO - 'branch': 'B2G-Inbound-Non-PGO', 09:09:38 INFO - 'buildbot_json_path': 'buildprops.json', 09:09:38 INFO - 'config_files': ('talos/linux_config.py',), 09:09:38 INFO - 'default_actions': ('clobber', 09:09:38 INFO - 'read-buildbot-config', 09:09:38 INFO - 'download-and-extract', 09:09:38 INFO - 'populate-webroot', 09:09:38 INFO - 'create-virtualenv', 09:09:38 INFO - 'install', 09:09:38 INFO - 'run-tests'), 09:09:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:09:38 INFO - 'download_minidump_stackwalk': True, 09:09:38 INFO - 'download_symbols': 'ondemand', 09:09:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:09:38 INFO - 'tooltool.py': '/tools/tooltool.py', 09:09:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:09:38 INFO - '/tools/misc-python/virtualenv.py')}, 09:09:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:09:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:09:38 INFO - 'installer_path': 'installer.exe', 09:09:38 INFO - 'log_level': 'info', 09:09:38 INFO - 'log_name': 'talos', 09:09:38 INFO - 'log_to_console': True, 09:09:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:09:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:09:38 INFO - 'opt_config_files': (), 09:09:38 INFO - 'pip_index': False, 09:09:38 INFO - 'sps_profile': False, 09:09:38 INFO - 'sps_profile_interval': 0, 09:09:38 INFO - 'suite': 'dromaeojs', 09:09:38 INFO - 'system_bits': '64', 09:09:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:09:38 INFO - 'title': 'talos-linux64-ix-009', 09:09:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:09:38 INFO - 'use_talos_json': True, 09:09:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:09:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:09:38 INFO - 'work_dir': 'build'} 09:09:38 INFO - ##### 09:09:38 INFO - ##### Running clobber step. 09:09:38 INFO - ##### 09:09:38 INFO - Running pre-action listener: _resource_record_pre_action 09:09:38 INFO - Running main action method: clobber 09:09:38 INFO - rmtree: /builds/slave/test/build 09:09:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:09:39 INFO - Running post-action listener: _resource_record_post_action 09:09:39 INFO - ##### 09:09:39 INFO - ##### Running read-buildbot-config step. 09:09:39 INFO - ##### 09:09:39 INFO - Running pre-action listener: _resource_record_pre_action 09:09:39 INFO - Running main action method: read_buildbot_config 09:09:39 INFO - Using buildbot properties: 09:09:39 INFO - { 09:09:39 INFO - "properties": { 09:09:39 INFO - "buildnumber": 763, 09:09:39 INFO - "product": "firefox", 09:09:39 INFO - "script_repo_revision": "production", 09:09:39 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 09:09:39 INFO - "repository": "", 09:09:39 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 09:09:39 INFO - "buildid": "20151119080012", 09:09:39 INFO - "slavename": "talos-linux64-ix-009", 09:09:39 INFO - "pgo_build": "False", 09:09:39 INFO - "basedir": "/builds/slave/test", 09:09:39 INFO - "project": "", 09:09:39 INFO - "platform": "ubuntu64_hw", 09:09:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:09:39 INFO - "slavebuilddir": "test", 09:09:39 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 09:09:39 INFO - "branch": "b2g-inbound", 09:09:39 INFO - "repo_path": "integration/b2g-inbound", 09:09:39 INFO - "stage_platform": "linux64", 09:09:39 INFO - "builduid": "0ffbdb19c32448e49648de6c708daaf5", 09:09:39 INFO - "revision": "8703ad09f2074b06d8e455e992c5f5a4c3b4e1b3" 09:09:39 INFO - }, 09:09:39 INFO - "sourcestamp": { 09:09:39 INFO - "repository": "", 09:09:39 INFO - "hasPatch": false, 09:09:39 INFO - "project": "", 09:09:39 INFO - "branch": "b2g-inbound-linux64-talos", 09:09:39 INFO - "changes": [ 09:09:39 INFO - { 09:09:39 INFO - "category": null, 09:09:39 INFO - "files": [ 09:09:39 INFO - { 09:09:39 INFO - "url": null, 09:09:39 INFO - "name": "https://queue.taskcluster.net/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:09:39 INFO - } 09:09:39 INFO - ], 09:09:39 INFO - "repository": "", 09:09:39 INFO - "rev": "8703ad09f2074b06d8e455e992c5f5a4c3b4e1b3", 09:09:39 INFO - "who": "cbook@mozilla.com", 09:09:39 INFO - "when": 1447950689, 09:09:39 INFO - "number": 6683523, 09:09:39 INFO - "comments": "Bug 1055959 - [NFC] testNfcBadSessionIdError testcase fail. r=yoshi", 09:09:39 INFO - "project": "", 09:09:39 INFO - "at": "Thu 19 Nov 2015 08:31:29", 09:09:39 INFO - "branch": "b2g-inbound-linux64-talos", 09:09:39 INFO - "revlink": "", 09:09:39 INFO - "properties": [ 09:09:39 INFO - [ 09:09:39 INFO - "buildid", 09:09:39 INFO - "20151119080012", 09:09:39 INFO - "Change" 09:09:39 INFO - ], 09:09:39 INFO - [ 09:09:39 INFO - "builduid", 09:09:39 INFO - "0ffbdb19c32448e49648de6c708daaf5", 09:09:39 INFO - "Change" 09:09:39 INFO - ], 09:09:39 INFO - [ 09:09:39 INFO - "pgo_build", 09:09:39 INFO - "False", 09:09:39 INFO - "Change" 09:09:39 INFO - ] 09:09:39 INFO - ], 09:09:39 INFO - "revision": "8703ad09f2074b06d8e455e992c5f5a4c3b4e1b3" 09:09:39 INFO - } 09:09:39 INFO - ], 09:09:39 INFO - "revision": "8703ad09f2074b06d8e455e992c5f5a4c3b4e1b3" 09:09:39 INFO - } 09:09:39 INFO - } 09:09:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:09:39 INFO - Running post-action listener: _resource_record_post_action 09:09:39 INFO - ##### 09:09:39 INFO - ##### Running download-and-extract step. 09:09:39 INFO - ##### 09:09:39 INFO - Running pre-action listener: _resource_record_pre_action 09:09:39 INFO - Running main action method: download_and_extract 09:09:39 INFO - mkdir: /builds/slave/test/build/tests 09:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:39 INFO - https://queue.taskcluster.net/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:09:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/test_packages.json 09:09:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/test_packages.json 09:09:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:09:40 INFO - Downloaded 1302 bytes. 09:09:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:09:40 INFO - Using the following test package requirements: 09:09:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:09:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:09:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:40 INFO - u'jsshell-linux-x86_64.zip'], 09:09:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:09:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:09:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:09:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:09:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:09:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:09:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:09:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:09:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:09: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')]} 09:09:40 INFO - https://queue.taskcluster.net/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:09:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:09:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:09:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/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 09:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/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 09:09:41 INFO - Downloaded 21336235 bytes. 09:09: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 09:09:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:09: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 09:09:42 INFO - Return code: 0 09:09: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 09:09: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')]} 09:09:42 INFO - https://queue.taskcluster.net/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:09:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:09:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:09:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/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 09:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/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 09:09:43 INFO - Downloaded 21336235 bytes. 09:09:43 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 09:09:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:09:43 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 09:09:44 INFO - Return code: 0 09:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:44 INFO - https://queue.taskcluster.net/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:09:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:09:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:09:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/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 09:09:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/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 09:09:45 INFO - Downloaded 11130997 bytes. 09:09:45 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 09:09:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:09:45 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 09:09:45 INFO - Return code: 0 09:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:45 INFO - https://queue.taskcluster.net/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:09:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:09:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:09:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/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 09:09:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0nMeCn8SRx6MiafmseEL7w/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 09:09:47 INFO - Downloaded 55783660 bytes. 09:09:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:09:47 INFO - mkdir: /builds/slave/test/properties 09:09:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:09:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:09:47 INFO - Contents: 09:09:47 INFO - build_url:https://queue.taskcluster.net/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:09:47 INFO - Running post-action listener: _resource_record_post_action 09:09:47 INFO - Running post-action listener: set_extra_try_arguments 09:09:47 INFO - ##### 09:09:47 INFO - ##### Running populate-webroot step. 09:09:47 INFO - ##### 09:09:47 INFO - Running pre-action listener: _resource_record_pre_action 09:09:47 INFO - Running main action method: populate_webroot 09:09:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:09:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:09:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:09:47 INFO - '../fennec_ids.txt'], 09:09:47 INFO - 'tests': ['tcheck2']}, 09:09:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:09:47 INFO - '--tppagecycles', 09:09:47 INFO - '7'], 09:09:47 INFO - 'tests': ['tsvgm']}}, 09:09:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:09:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:09:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:09:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:09:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:09:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:09:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:47 INFO - 'talos_options': ['--e10s'], 09:09:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:47 INFO - 'tests': ['damp', 'tps']}, 09:09:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:47 INFO - 'talos_options': ['--e10s'], 09:09:47 INFO - 'tests': ['damp', 'tps']}, 09:09:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:09:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:09:47 INFO - 'other': {'tests': ['a11yr', 09:09:47 INFO - 'ts_paint', 09:09:47 INFO - 'tpaint', 09:09:47 INFO - 'sessionrestore', 09:09:47 INFO - 'sessionrestore_no_auto_restore']}, 09:09:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:09:47 INFO - 'tests': ['a11yr', 09:09:47 INFO - 'ts_paint', 09:09:47 INFO - 'tpaint', 09:09:47 INFO - 'sessionrestore', 09:09:47 INFO - 'sessionrestore_no_auto_restore']}, 09:09:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:09:47 INFO - 'tests': ['a11yr', 09:09:47 INFO - 'ts_paint', 09:09:47 INFO - 'tpaint', 09:09:47 INFO - 'sessionrestore', 09:09:47 INFO - 'sessionrestore_no_auto_restore']}, 09:09:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:09:47 INFO - 'tests': ['a11yr', 09:09:47 INFO - 'ts_paint', 09:09:47 INFO - 'tpaint', 09:09:47 INFO - 'sessionrestore', 09:09:47 INFO - 'sessionrestore_no_auto_restore']}, 09:09:47 INFO - 'other_l64': {'tests': ['a11yr', 09:09:47 INFO - 'ts_paint', 09:09:47 INFO - 'tpaint', 09:09:47 INFO - 'sessionrestore', 09:09:47 INFO - 'sessionrestore_no_auto_restore']}, 09:09:47 INFO - 'other_nol64': {'tests': ['a11yr', 09:09:47 INFO - 'ts_paint', 09:09:47 INFO - 'tpaint', 09:09:47 INFO - 'sessionrestore', 09:09:47 INFO - 'sessionrestore_no_auto_restore']}, 09:09:47 INFO - 'svgr': {'tests': ['tsvgx', 09:09:47 INFO - 'tsvgr_opacity', 09:09:47 INFO - 'tart', 09:09:47 INFO - 'tscrollx', 09:09:47 INFO - 'cart']}, 09:09:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:09:47 INFO - 'tests': ['tsvgx', 09:09:47 INFO - 'tsvgr_opacity', 09:09:47 INFO - 'tart', 09:09:47 INFO - 'tscrollx', 09:09:47 INFO - 'cart']}, 09:09:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:47 INFO - 'tests': ['tp5o']}, 09:09:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:47 INFO - 'talos_options': ['--e10s'], 09:09:47 INFO - 'tests': ['tp5o']}, 09:09:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:47 INFO - 'talos_options': ['--xperf_path', 09:09:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:09:47 INFO - 'tests': ['tp5n']}, 09:09:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:47 INFO - 'talos_options': ['--e10s', 09:09:47 INFO - '--xperf_path', 09:09:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:09:47 INFO - 'tests': ['tp5n']}}, 09:09:47 INFO - 'talos.zip': {'path': '', 09:09:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:09:47 INFO - Running post-action listener: _resource_record_post_action 09:09:47 INFO - ##### 09:09:47 INFO - ##### Running create-virtualenv step. 09:09:47 INFO - ##### 09:09:47 INFO - Running pre-action listener: _resource_record_pre_action 09:09:47 INFO - Running main action method: create_virtualenv 09:09:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:09:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:09:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:09:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:09:47 INFO - Using real prefix '/usr' 09:09:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:09:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:09:50 INFO - Installing pip.................done. 09:09:50 INFO - Return code: 0 09:09:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeab694c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c0b70>, '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 0x1411dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1412250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', '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 09:09:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:09:50 INFO - Using env: {'DISPLAY': ':0', 09:09:50 INFO - 'HOME': '/home/cltbld', 09:09:50 INFO - 'LANG': 'en_US.UTF-8', 09:09:50 INFO - 'LANGUAGE': 'en_US:en', 09:09:50 INFO - 'LOGNAME': 'cltbld', 09:09:50 INFO - 'MAIL': '/var/mail/cltbld', 09:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:50 INFO - 'MOZ_NO_REMOTE': '1', 09:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:50 INFO - 'NO_EM_RESTART': '1', 09:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:50 INFO - 'PWD': '/builds/slave/test', 09:09:50 INFO - 'SHELL': '/bin/bash', 09:09:50 INFO - 'SHLVL': '1', 09:09:50 INFO - 'TERM': 'linux', 09:09:50 INFO - 'TMOUT': '86400', 09:09:50 INFO - 'USER': 'cltbld', 09:09:50 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', 09:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:50 INFO - '_': '/tools/buildbot/bin/python'} 09:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:09:50 INFO - Cleaning up... 09:09:50 INFO - Return code: 0 09:09:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeab694c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c0b70>, '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 0x1411dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1412250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', '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 09:09:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:09:50 INFO - Using env: {'DISPLAY': ':0', 09:09:50 INFO - 'HOME': '/home/cltbld', 09:09:50 INFO - 'LANG': 'en_US.UTF-8', 09:09:50 INFO - 'LANGUAGE': 'en_US:en', 09:09:50 INFO - 'LOGNAME': 'cltbld', 09:09:50 INFO - 'MAIL': '/var/mail/cltbld', 09:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:50 INFO - 'MOZ_NO_REMOTE': '1', 09:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:50 INFO - 'NO_EM_RESTART': '1', 09:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:50 INFO - 'PWD': '/builds/slave/test', 09:09:50 INFO - 'SHELL': '/bin/bash', 09:09:50 INFO - 'SHLVL': '1', 09:09:50 INFO - 'TERM': 'linux', 09:09:50 INFO - 'TMOUT': '86400', 09:09:50 INFO - 'USER': 'cltbld', 09:09:50 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', 09:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:50 INFO - '_': '/tools/buildbot/bin/python'} 09:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:50 INFO - Downloading/unpacking psutil>=0.7.1 09:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:09:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:09:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:52 INFO - Installing collected packages: psutil 09:09:52 INFO - Running setup.py install for psutil 09:09:52 INFO - building 'psutil._psutil_linux' extension 09:09:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:09:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:09:52 INFO - building 'psutil._psutil_posix' extension 09:09:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:09:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:09:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:52 INFO - Successfully installed psutil 09:09:52 INFO - Cleaning up... 09:09:52 INFO - Return code: 0 09:09:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeab694c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c0b70>, '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 0x1411dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1412250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', '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 09:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:09:52 INFO - Using env: {'DISPLAY': ':0', 09:09:52 INFO - 'HOME': '/home/cltbld', 09:09:52 INFO - 'LANG': 'en_US.UTF-8', 09:09:52 INFO - 'LANGUAGE': 'en_US:en', 09:09:52 INFO - 'LOGNAME': 'cltbld', 09:09:52 INFO - 'MAIL': '/var/mail/cltbld', 09:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:52 INFO - 'MOZ_NO_REMOTE': '1', 09:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:52 INFO - 'NO_EM_RESTART': '1', 09:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:52 INFO - 'PWD': '/builds/slave/test', 09:09:52 INFO - 'SHELL': '/bin/bash', 09:09:52 INFO - 'SHLVL': '1', 09:09:52 INFO - 'TERM': 'linux', 09:09:52 INFO - 'TMOUT': '86400', 09:09:52 INFO - 'USER': 'cltbld', 09:09:52 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', 09:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:52 INFO - '_': '/tools/buildbot/bin/python'} 09:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:09:53 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 09:09:53 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 09:09:53 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 09:09:53 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 09:09:53 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 09:09:53 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 09:09:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:09:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:09:54 INFO - Installing collected packages: mozsystemmonitor 09:09:54 INFO - Running setup.py install for mozsystemmonitor 09:09:54 INFO - Successfully installed mozsystemmonitor 09:09:54 INFO - Cleaning up... 09:09:54 INFO - Return code: 0 09:09:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeab694c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c0b70>, '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 0x1411dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1412250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', '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 09:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:09:54 INFO - Using env: {'DISPLAY': ':0', 09:09:54 INFO - 'HOME': '/home/cltbld', 09:09:54 INFO - 'LANG': 'en_US.UTF-8', 09:09:54 INFO - 'LANGUAGE': 'en_US:en', 09:09:54 INFO - 'LOGNAME': 'cltbld', 09:09:54 INFO - 'MAIL': '/var/mail/cltbld', 09:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:54 INFO - 'MOZ_NO_REMOTE': '1', 09:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:54 INFO - 'NO_EM_RESTART': '1', 09:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:54 INFO - 'PWD': '/builds/slave/test', 09:09:54 INFO - 'SHELL': '/bin/bash', 09:09:54 INFO - 'SHLVL': '1', 09:09:54 INFO - 'TERM': 'linux', 09:09:54 INFO - 'TMOUT': '86400', 09:09:54 INFO - 'USER': 'cltbld', 09:09:54 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', 09:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:54 INFO - '_': '/tools/buildbot/bin/python'} 09:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:55 INFO - Downloading/unpacking blobuploader==1.2.4 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09: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 09:09:56 INFO - Downloading blobuploader-1.2.4.tar.gz 09:09:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:09:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:09:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:57 INFO - Downloading docopt-0.6.1.tar.gz 09:09:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:09:57 INFO - Installing collected packages: blobuploader, requests, docopt 09:09:57 INFO - Running setup.py install for blobuploader 09:09:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:09:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:09:57 INFO - Running setup.py install for requests 09:09:57 INFO - Running setup.py install for docopt 09:09:58 INFO - Successfully installed blobuploader requests docopt 09:09:58 INFO - Cleaning up... 09:09:58 INFO - Return code: 0 09:09:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:58 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')]} 09:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:58 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')]} 09:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:58 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 0x7fdeab694c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c0b70>, '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 0x1411dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1412250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', '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 09:09:58 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 09:09:58 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 09:09:58 INFO - Using env: {'DISPLAY': ':0', 09:09:58 INFO - 'HOME': '/home/cltbld', 09:09:58 INFO - 'LANG': 'en_US.UTF-8', 09:09:58 INFO - 'LANGUAGE': 'en_US:en', 09:09:58 INFO - 'LOGNAME': 'cltbld', 09:09:58 INFO - 'MAIL': '/var/mail/cltbld', 09:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:58 INFO - 'MOZ_NO_REMOTE': '1', 09:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:58 INFO - 'NO_EM_RESTART': '1', 09:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:58 INFO - 'PWD': '/builds/slave/test', 09:09:58 INFO - 'SHELL': '/bin/bash', 09:09:58 INFO - 'SHLVL': '1', 09:09:58 INFO - 'TERM': 'linux', 09:09:58 INFO - 'TMOUT': '86400', 09:09:58 INFO - 'USER': 'cltbld', 09:09:58 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', 09:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:58 INFO - '_': '/tools/buildbot/bin/python'} 09:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:58 INFO - Running setup.py (path:/tmp/pip-M0thLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:58 INFO - Running setup.py (path:/tmp/pip-8FDB6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:58 INFO - Running setup.py (path:/tmp/pip-NDg7Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:58 INFO - Running setup.py (path:/tmp/pip-ZBvLL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:58 INFO - Running setup.py (path:/tmp/pip-HLuytz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:58 INFO - Running setup.py (path:/tmp/pip-O2_Wdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:58 INFO - Running setup.py (path:/tmp/pip-TMYc35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:58 INFO - Running setup.py (path:/tmp/pip-EhdGGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:58 INFO - Running setup.py (path:/tmp/pip-fQq9JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:58 INFO - Running setup.py (path:/tmp/pip-Shv3kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:59 INFO - Running setup.py (path:/tmp/pip-VyS_44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:59 INFO - Running setup.py (path:/tmp/pip-XvOjpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:59 INFO - Running setup.py (path:/tmp/pip-HAvU5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:59 INFO - Running setup.py (path:/tmp/pip-Mf6j0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:59 INFO - Running setup.py (path:/tmp/pip-ZD5ZIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:59 INFO - Running setup.py (path:/tmp/pip-LqWv1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:59 INFO - Running setup.py (path:/tmp/pip-4W1U4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:09:59 INFO - Running setup.py install for manifestparser 09:09:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:09:59 INFO - Running setup.py install for mozcrash 09:09:59 INFO - Running setup.py install for mozdebug 09:09:59 INFO - Running setup.py install for mozdevice 09:09:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:09:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:09:59 INFO - Running setup.py install for mozfile 09:10:00 INFO - Running setup.py install for mozhttpd 09:10:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:10:00 INFO - Running setup.py install for mozinfo 09:10:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:10:00 INFO - Running setup.py install for mozInstall 09:10:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:10:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:10:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:10:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:10:00 INFO - Running setup.py install for mozleak 09:10:00 INFO - Running setup.py install for mozlog 09:10:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:10:00 INFO - Running setup.py install for moznetwork 09:10:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:10:00 INFO - Running setup.py install for mozprocess 09:10:00 INFO - Running setup.py install for mozprofile 09:10:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:10:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:10:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:10:00 INFO - Running setup.py install for mozrunner 09:10:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:10:00 INFO - Running setup.py install for mozscreenshot 09:10:01 INFO - Running setup.py install for moztest 09:10:01 INFO - Running setup.py install for mozversion 09:10:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:10:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:10:01 INFO - Cleaning up... 09:10:01 INFO - Return code: 0 09:10:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10: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')]} 09:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10: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')]} 09:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeab694c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c0b70>, '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 0x1411dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1412250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', '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 09:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:10:01 INFO - Using env: {'DISPLAY': ':0', 09:10:01 INFO - 'HOME': '/home/cltbld', 09:10:01 INFO - 'LANG': 'en_US.UTF-8', 09:10:01 INFO - 'LANGUAGE': 'en_US:en', 09:10:01 INFO - 'LOGNAME': 'cltbld', 09:10:01 INFO - 'MAIL': '/var/mail/cltbld', 09:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:01 INFO - 'MOZ_NO_REMOTE': '1', 09:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:01 INFO - 'NO_EM_RESTART': '1', 09:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:01 INFO - 'PWD': '/builds/slave/test', 09:10:01 INFO - 'SHELL': '/bin/bash', 09:10:01 INFO - 'SHLVL': '1', 09:10:01 INFO - 'TERM': 'linux', 09:10:01 INFO - 'TMOUT': '86400', 09:10:01 INFO - 'USER': 'cltbld', 09:10:01 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', 09:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:01 INFO - '_': '/tools/buildbot/bin/python'} 09:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:10:01 INFO - Running setup.py (path:/tmp/pip-zhjJLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:10:01 INFO - Running setup.py (path:/tmp/pip-PeHmeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:10:01 INFO - Running setup.py (path:/tmp/pip-jf2v0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:10:01 INFO - Running setup.py (path:/tmp/pip-iWa0EV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:10:01 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)) 09:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:10:01 INFO - Running setup.py (path:/tmp/pip-7J7lSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:10:01 INFO - Running setup.py (path:/tmp/pip-S9QbX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:10:01 INFO - Running setup.py (path:/tmp/pip-4hJBE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:10:02 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)) 09:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:10:02 INFO - Running setup.py (path:/tmp/pip-eEQt7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:10:02 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)) 09:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:10:02 INFO - Running setup.py (path:/tmp/pip-hv2ILn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:10:02 INFO - Running setup.py (path:/tmp/pip-5Kxm9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:10:02 INFO - Running setup.py (path:/tmp/pip-0iD9r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:10:02 INFO - Running setup.py (path:/tmp/pip-8eALq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:10:02 INFO - Running setup.py (path:/tmp/pip-6qpcG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:10:02 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)) 09:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:10:02 INFO - Running setup.py (path:/tmp/pip-wHQDbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:02 INFO - Running setup.py (path:/tmp/pip-Oqsutg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:10:02 INFO - Running setup.py (path:/tmp/pip-MxyWl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:10:02 INFO - Running setup.py (path:/tmp/pip-xCtUIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:10:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:10: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 09:10: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 09:10: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 09:10: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 09:10: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 09:10: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 09:10:04 INFO - Downloading blessings-1.5.1.tar.gz 09:10:04 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:10:04 INFO - Installing collected packages: blessings 09:10:04 INFO - Running setup.py install for blessings 09:10:04 INFO - Successfully installed blessings 09:10:04 INFO - Cleaning up... 09:10:04 INFO - Return code: 0 09:10:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:10:04 INFO - Reading from file tmpfile_stdout 09:10:04 INFO - Current package versions: 09:10:04 INFO - argparse == 1.2.1 09:10:04 INFO - blessings == 1.5.1 09:10:04 INFO - blobuploader == 1.2.4 09:10:04 INFO - docopt == 0.6.1 09:10:04 INFO - manifestparser == 1.1 09:10:04 INFO - mozInstall == 1.12 09:10:04 INFO - mozcrash == 0.16 09:10:04 INFO - mozdebug == 0.1 09:10:04 INFO - mozdevice == 0.47 09:10:04 INFO - mozfile == 1.2 09:10:04 INFO - mozhttpd == 0.7 09:10:04 INFO - mozinfo == 0.9 09:10:04 INFO - mozleak == 0.1 09:10:04 INFO - mozlog == 3.0 09:10:04 INFO - moznetwork == 0.27 09:10:04 INFO - mozprocess == 0.22 09:10:04 INFO - mozprofile == 0.27 09:10:04 INFO - mozrunner == 6.11 09:10:04 INFO - mozscreenshot == 0.1 09:10:04 INFO - mozsystemmonitor == 0.0 09:10:04 INFO - moztest == 0.7 09:10:04 INFO - mozversion == 1.4 09:10:04 INFO - psutil == 3.1.1 09:10:04 INFO - requests == 1.2.3 09:10:04 INFO - wsgiref == 0.1.2 09:10:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeab694c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c0b70>, '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 0x1411dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1412250>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', '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 09:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:10:04 INFO - Using env: {'DISPLAY': ':0', 09:10:04 INFO - 'HOME': '/home/cltbld', 09:10:04 INFO - 'LANG': 'en_US.UTF-8', 09:10:04 INFO - 'LANGUAGE': 'en_US:en', 09:10:04 INFO - 'LOGNAME': 'cltbld', 09:10:04 INFO - 'MAIL': '/var/mail/cltbld', 09:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:04 INFO - 'MOZ_NO_REMOTE': '1', 09:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:04 INFO - 'NO_EM_RESTART': '1', 09:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:04 INFO - 'PWD': '/builds/slave/test', 09:10:04 INFO - 'SHELL': '/bin/bash', 09:10:04 INFO - 'SHLVL': '1', 09:10:04 INFO - 'TERM': 'linux', 09:10:04 INFO - 'TMOUT': '86400', 09:10:04 INFO - 'USER': 'cltbld', 09:10:04 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', 09:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:04 INFO - '_': '/tools/buildbot/bin/python'} 09:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:05 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)) 09:10:05 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)) 09:10:05 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)) 09:10:05 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)) 09:10:05 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)) 09:10:05 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)) 09:10:05 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)) 09:10:05 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)) 09:10:05 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)) 09:10:05 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)) 09:10:05 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)) 09:10:05 INFO - Cleaning up... 09:10:05 INFO - Return code: 0 09:10:05 INFO - Running post-action listener: _resource_record_post_action 09:10:05 INFO - Running post-action listener: _start_resource_monitoring 09:10:05 INFO - Starting resource monitoring. 09:10:05 INFO - ##### 09:10:05 INFO - ##### Running install step. 09:10:05 INFO - ##### 09:10:05 INFO - Running pre-action listener: _resource_record_pre_action 09:10:05 INFO - Running main action method: install 09:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:10:05 INFO - Reading from file tmpfile_stdout 09:10:05 INFO - Detecting whether we're running mozinstall >=1.0... 09:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:10:05 INFO - Reading from file tmpfile_stdout 09:10:05 INFO - Output received: 09:10:05 INFO - Usage: mozinstall [options] installer 09:10:05 INFO - Options: 09:10:05 INFO - -h, --help show this help message and exit 09:10:05 INFO - -d DEST, --destination=DEST 09:10:05 INFO - Directory to install application into. [default: 09:10:05 INFO - "/builds/slave/test"] 09:10:05 INFO - --app=APP Application being installed. [default: firefox] 09:10:05 INFO - mkdir: /builds/slave/test/build/application 09:10:05 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'] 09:10:05 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 09:10:19 INFO - Reading from file tmpfile_stdout 09:10:19 INFO - Output received: 09:10:19 INFO - /builds/slave/test/build/application/firefox/firefox 09:10:19 INFO - Running post-action listener: _resource_record_post_action 09:10:19 INFO - ##### 09:10:19 INFO - ##### Running run-tests step. 09:10:19 INFO - ##### 09:10:19 INFO - Running pre-action listener: _resource_record_pre_action 09:10:19 INFO - Running main action method: run_tests 09:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:10:19 INFO - Python 2.7.3 09:10:19 INFO - Return code: 0 09:10:19 INFO - grabbing minidump binary from tooltool 09:10:19 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')]} 09:10:19 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 0x13c0b70>, '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 0x1411dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1412250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:10:19 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 09:10:19 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 09:10:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:10:19 INFO - Return code: 0 09:10:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:10:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:10:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:10:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:10:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:10:19 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/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] in /builds/slave/test/build 09:10:19 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/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost 09:10:19 INFO - Using env: {'DISPLAY': ':0', 09:10:19 INFO - 'HOME': '/home/cltbld', 09:10:19 INFO - 'LANG': 'en_US.UTF-8', 09:10:19 INFO - 'LANGUAGE': 'en_US:en', 09:10:19 INFO - 'LOGNAME': 'cltbld', 09:10:19 INFO - 'MAIL': '/var/mail/cltbld', 09:10:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:10:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:19 INFO - 'MOZ_NO_REMOTE': '1', 09:10:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:19 INFO - 'NO_EM_RESTART': '1', 09:10:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:19 INFO - 'PWD': '/builds/slave/test', 09:10:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:10:19 INFO - 'SHELL': '/bin/bash', 09:10:19 INFO - 'SHLVL': '1', 09:10:19 INFO - 'TERM': 'linux', 09:10:19 INFO - 'TMOUT': '86400', 09:10:19 INFO - 'USER': 'cltbld', 09:10:19 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130', 09:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:19 INFO - '_': '/tools/buildbot/bin/python'} 09:10:19 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/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] with output_timeout 3600 09:10:19 INFO - mozversion INFO | application_buildid: 20151119080012 09:10:19 INFO - mozversion INFO | application_changeset: 8703ad09f2074b06d8e455e992c5f5a4c3b4e1b3 09:10:19 INFO - mozversion INFO | application_display_name: Nightly 09:10:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:10:19 INFO - mozversion INFO | application_name: Firefox 09:10:19 INFO - mozversion INFO | application_remotingname: firefox 09:10:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 09:10:19 INFO - mozversion INFO | application_vendor: Mozilla 09:10:19 INFO - mozversion INFO | application_version: 45.0a1 09:10:19 INFO - mozversion INFO | platform_buildid: 20151119080012 09:10:19 INFO - mozversion INFO | platform_changeset: 8703ad09f2074b06d8e455e992c5f5a4c3b4e1b3 09:10:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 09:10:19 INFO - mozversion INFO | platform_version: 45.0a1 09:10:19 INFO - 2015-11-19 09:10:19,788 DEBUG : using testdate: 1447953019 09:10:19 INFO - 2015-11-19 09:10:19,788 DEBUG : actual date: 1447953019 09:10:19 INFO - 2015-11-19 09:10:19,878 INFO : starting webserver on 'localhost:40497' 09:10:19 INFO - 2015-11-19 09:10:19,879 INFO : Starting test suite talos-linux64-ix-009 09:10:19 INFO - 2015-11-19 09:10:19,879 INFO : Starting test dromaeo_css 09:10:19 INFO - 2015-11-19 09:10:19,879 DEBUG : operating with platform_type : linux_ 09:10:19 INFO - 2015-11-19 09:10:19,880 INFO : Initialising browser for dromaeo_css test... 09:10:19 INFO - 2015-11-19 09:10:19,890 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVlDzUJ/profile http://localhost:40497/getInfo.html 09:10:25 INFO - 2015-11-19 09:10:25,162 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:10:25 INFO - 2015-11-19 09:10:25,162 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:10:25 INFO - 2015-11-19 09:10:25,162 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:10:25 INFO - 2015-11-19 09:10:25,162 DEBUG : BROWSER_OUTPUT: __metrics 09:10:25 INFO - 2015-11-19 09:10:25,238 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:26 INFO - 2015-11-19 09:10:26,660 INFO : Browser initialized. 09:10:26 INFO - 2015-11-19 09:10:26,661 INFO : Running cycle 1/1 for dromaeo_css test... 09:10:26 INFO - 2015-11-19 09:10:26,661 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVlDzUJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:10:38 INFO - 2015-11-19 09:10:38,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 141434880 09:10:38 INFO - 2015-11-19 09:10:38,635 DEBUG : BROWSER_OUTPUT: 09:11:29 INFO - 2015-11-19 09:11:29,737 DEBUG : BROWSER_OUTPUT: 1447953089736 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] 09:13:41 INFO - 2015-11-19 09:13:41,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40497/tests/dromaeo/cssquery-ext.html) 09:13:43 INFO - 2015-11-19 09:13:43,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 264695808 09:13:43 INFO - 2015-11-19 09:13:43,064 DEBUG : BROWSER_OUTPUT: 09:16:45 INFO - 2015-11-19 09:16:45,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/dromaeo/cssquery-ext.html (next: http://localhost:40497/tests/dromaeo/cssquery-jquery.html) 09:16:46 INFO - 2015-11-19 09:16:46,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 218710016 09:16:46 INFO - 2015-11-19 09:16:46,228 DEBUG : BROWSER_OUTPUT: 09:19:48 INFO - 2015-11-19 09:19:48,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40497/tests/dromaeo/cssquery-mootools.html) 09:19:48 INFO - 2015-11-19 09:19:48,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 212344832 09:19:48 INFO - 2015-11-19 09:19:48,813 DEBUG : BROWSER_OUTPUT: 09:22:50 INFO - 2015-11-19 09:22:50,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40497/tests/dromaeo/cssquery-prototype.html) 09:22:51 INFO - 2015-11-19 09:22:51,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 202051584 09:22:51 INFO - 2015-11-19 09:22:51,374 DEBUG : BROWSER_OUTPUT: 09:25:54 INFO - 2015-11-19 09:25:54,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40497/tests/dromaeo/cssquery-yui.html) 09:25:54 INFO - 2015-11-19 09:25:54,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 207589376 09:25:54 INFO - 2015-11-19 09:25:54,662 DEBUG : BROWSER_OUTPUT: 09:28:57 INFO - 2015-11-19 09:28:57,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/dromaeo/cssquery-yui.html (next: http://localhost:40497/tests/dromaeo/cssquery-dojo.html) 09:28:57 INFO - 2015-11-19 09:28:57,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 245932032 09:28:57 INFO - 2015-11-19 09:28:57,533 DEBUG : BROWSER_OUTPUT: 09:28:57 INFO - 2015-11-19 09:28:57,533 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:28:57 INFO - 2015-11-19 09:28:57,533 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:28:57 INFO - 2015-11-19 09:28:57,533 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:28:57 INFO - 2015-11-19 09:28:57,534 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:28:57 INFO - 2015-11-19 09:28:57,537 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2607.4654695787367;2720.061578755329;2731.399092199718;2747.3131717070733;2753.9999999999995;4653.3717948077;4777.498362671921;4798.640101992351;4818.975905120474;4835.854924352267;4727.267273572593;4756.977249891282;4825.252085926687;4825.372701548802;4853.1506986277345;4405.735655860651;4430.246858034142;4462.062966776981;4481.327800829869;4482.753448560328;4202.621764041236;4511.255642818947;4537.4328208973875;4558.954410455886;4564.2012647786505;4310.956890431118;4388.1004394099455;4422.646188304928;4446.622037126832;4466.3747075409465;4448.532904045061;4453.064856380164;4462.776861156929;4469.575390337913;4497.7526236057;4430.579094985971;4438.245498265303;4451.888702782457;4461.70116631828;4481.686281960264;4588.128255631419;4695.5069717679835;4698.553637404441;4714.787834547454;4856.975715121437;5081.59347252219;5092.9745351273;5093.057784309877;5095.770690318945;5096.031753966735;5097.46476619957;5105.285260063594;5147.48525147486;5252.422233554306;5300.01949639318;4858.78135483904;4876.780544875418;4879.414470263556;4881.609471242292;4932.136876046678;5330.680159190461;5374.8656283592445;5386.057439947994;5395.379531353866;5400.135978243541;4887.902241955141;4982.701037937735;4991.5258050485145;4996.950030499721;5116.513931176532;5172.844814655491;5194;5215.739213039333;5223.216517522402;5225.790968361299;5157.123289040872;5171.3535808024;5173.844784656391;5177.663451875616;5207.557357624644;4866.221404575251;4963.950360496421;4965.90068198634;5025.246213068069;5152.355955505562;4331.740095594275;4338.739675619409;4371.540988196257;4384.254676704904;4407.471103467605;3764.962350376516;3775.8867233983024;3782.867599634;3807.2956503047026;3808.6762625176616;4282.63597594208;4363.956360436418;4375.978120109443;4384.802683879233;4480.843170489017;5168.586513078944;5177.58579313654;5187.818426355059;5189.351331083614;5221.791128354899;4416.933745993812;4425.09285596452;4427.092446048552;4433.246348120827;4447.110577884436;4508.774561271924;4527.388802511618;4622.375979242759;4624.213883639789;4637;4948.331975183304;4952.380952380952;4959.628027897994;4960.181570040902;4964.255361695775;5228.529432351107;5230.7384630769075;5230.921536176884;5233.058049551118;5270.314859068297;4745.525447455227;4846.466888642176;4860.465348811557;4950.257461380677;5002.574781143498;5121.795128194831;5184.818531351385;5188.844334669966;5192.1952097424955;5235.816746413857;5240.187770895517;5263.105272103828;5286.286351342519;5289.497497737709;5335.786568537215;4764.30917516965;4883.047805677858;4884.389451318585;5075.543201111917;5089.796408143633;4909.533594308535;4990.72551009698;4998.950010499849;5025.824096156617;5039.521245481674;4911.386076740408;4942.604591632733;4966.428860681068;4974.278729584263;5021.698698078127;4832.589229915497;4909.116359055404;5085.084684756632;5093;5154.484551544815;4821.734804585782;4865.610751139971;4894.388201474816;4923;4947.554720075211 09:28:57 INFO - 2015-11-19 09:28:57,537 DEBUG : BROWSER_OUTPUT: |1;ext.html;558;569.1604882797872;570.426721145249;572.6592677356974;582.1471544187764;27964.440711185765;28482.715172848264;37593.9323337216;38240.42639360405;38249.426258606145;40985.59014409863;41204.79397603015;41455.17089658205;41563;41635.16729665405;7050.29497050296;8003.719869804543;8087.191280871895;8179.263866252036;8182.345412367026;7131.821704457404;7224.7471338503165;7234.42124630031;7234.60209688467;10013.399196048224;10235.539400726986;10338.53476593555;10344.948275258614;10355.74110647236;10357.637482688107;10190.796184076315;10304.896951030507;10307.690769276935;10310.072093511544;10320.690379288633;7208.315210055036;7384.446166537531;10194.949025254826;10619.672540932383;10620.946895265552;37827.43258851092;38109.23781524354;38233.61766382329;38287;38406;2807.355768991876;2859.542473204298;2907.069737683942;3005.3989202159655;3335.382954153489;28503.85748071267;28681.79190175242;28770.42459150826;29050;29249.561256581168;2969.138949704605;3017.6077109975563;3020.864061117255;3068.769842261839;3102.4570700127615;229969;230186;231094;231415;232219;52163.47836521662;56040.43959560434;56058.159127613115;56545.43454565402;56574.07962885199;48198.27702584464;65965;67655.32344676589;67778;67785;12706.301153436465;12805.935970320088;12816.231026138461;12833.935830320788;12878.227306361649;10312.175025997902;10362.948185259176;10384.32501887375;10387.013233742933;10387.792244155075;18907.905460472608;19048.238070477302;19083.522911927314;19134;19206.135723892457;7131.71473141079;7392.889106663297;7401.185869554345;7417.8887316689215;7443.449764207463;838.5094719589109;847.3390755210945;908.5638893331238;966.7148191283588;1001.84972254161;26095.478090438464;26421;26867.193984180507;26944.730552694615;26954;942.8067246214509;943.4575119306427;949.0888746803008;1002.3434650304063;1003.5132960514145;12868.485260589472;13945.16329020262;14485.275736213147;14712.117272963656;14729.55811325662;255444;263992;264102;270568;271707;46104.7694761524;46274.53725462702;46342;46444.535554644695;46502.534974650494;1234.2594443333928;1238.4798384678456;1245.9501619935281;1246.9064820138526;1252.085977236604;20919.477013074797;26158.73841261563;27011.189664310103;27298.590521141803;27421.31446713848;38093.238135236585;38490;38515.61484385232;38551.6144838548;38594.2281154381;180336;181119;181346;181601;182284;24436.14473493419;24524.877375613007;24849.254522364357;26131.608025879246;26495;27579.586306205023;27842.582361265002;27856.16431507058;37419.62580374161;37751.62248377591;28789.28026799347;29634.259143521584;30077;30262.69737302599;30489.695103048685;30164.396712065198;30369.696303036686;30389.696103039572;30437.391252175275;30438.84780576083;30053.24866878258;30054.54918176273;30328.696713032587;30513.542296865122;30517;28355.43289134247;29236.26909327199;29824;29970.100896973127;30202.54696179515;22977;23781;24894.253172404857;25058.37354066163;25343.74656253414 09:28:57 INFO - 2015-11-19 09:28:57,541 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.520164169342;343.4076218523048;343.9071450708309;344.0401280427608;346.3523211594319;12646.747065058693;13072.215667059983;15256;15475;16695.66608667826;12704.301263430507;15252.694946101072;15697.29362178702;15781.368745250176;15794;4880.926786098212;5069.619778516608;5086.745662716868;5091.9236211456855;5097.872553186163;3590.46143078539;3708.35103856824;5090.287359769635;5131.563817075553;5139.48605139485;5579.7489112990015;5699.601027928046;5744.224529688501;5751.626144300628;5751.7699292028265;5516.531094856962;5588.050031494615;5590.552755779528;5701.543876489871;5711.514521265697;4834.468208497063;4848.127337079324;4848.927266091011;4849.951500484985;4867.3915760529935;19019;19084.71372929407;19304.42086737386;19324;19875.50311242216;1816.1464111867401;1821.3716267887557;1840.300685739424;1904.6381187574316;1947.6981067934494;12665.176763510342;12776.233425994471;12887.226766394046;13051.21692698441;13381.19712817234;1561.4066654671153;1587.246058122394;1617.0944271208161;1627.1620115640455;1718.9226484808214;53797;55852.44147558513;56208.71895640536;56712;56816;5993.490553303018;6021.42796434338;6022.5483088768515;6049.425304596057;6059.303180134253;6839.0425340452375;6846;6851.9657401712675;6852.486063545254;6855.485838562127;4691.976540117277;4721.386219791405;4736.384270044872;4743.573078422958;4785.3300537924715;4858.708477491362;4906.31311616374;4941.283513890466;4982.60139188864;4991.725455100004;2820.5910143029146;2849.3731379096566;2850.857457127135;2851.885924562994;2855.6858745537975;959.9664011759555;1001.2890847498358;1009.1926458833051;1013.5844303835393;1063.8085144673878;363.38225017470404;366.7402472506947;369.10492056762246;382.06584899919983;412.45967782205406;9783.657571985088;10427.739306517245;10573.101286390589;10738.624148154933;10779.568817247222;374.83694592852197;383.6361734035475;400.055868151163;402.5591976785415;403.57221345373995;5560.805371811967;5980.252468441445;6367.840803979845;6514.413702766774;6529.934700653028;444292;458474;460749;460754;461057;69403.65298173476;71239.6438017817;71356;72098.27901721021;72237;474.26015415951224;481.4367190387255;483.8766114640744;484.24941340922135;484.8424262114827;9384.906150938676;9591.9040809591;9872.605095796087;10642.201834862572;10666.679999600025;30109.69890301069;30220.395592087596;30994.380112397175;31379;31391.686083138877;38783.418248726855;39018.414723778595;39331.2133757329;39523.20953580855;39877.80061099676;5477.616566840283;5556.749946252509;5560.165975103767;5617.494425501724;5626.043572592587;11066.778664426827;11305.208635395444;11332.263402878787;11371.601993930173;11616.535338586362;10075.193984481077;10188.235882309005;10350.689479315633;10383.325083869524;10394.948025259826;9791.755206119904;10112.241581881535;10162.085412312632;10188.388696678223;10315.226358023028;8378.162183781573;10237.897621023993;10430.217733670157;10443.791124177626;10528.473576321;5198.376194856642;5605.607607467438;5654.378018418053;5669.461401166883;5706.343770466449;9747.415155090717;9941.801163976825;10033.899661003588;10094.24293178;10153.136983356497 09:28:57 INFO - 2015-11-19 09:28:57,541 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1437.7771445425963;1598.5603958911297;1647.9093649849253;1669.540876259029;1675.1121905390148;6020.217371741673;6158.476529494993;6608.603483790976;6789.4568434525245;6804.557703749265;6966.895496567556;6981.685824137913;7008.088948436696;7017.543859649119;7033.8944915826305;2046.130394582304;2059.70134330522;2067.6588362920174;2071.326818783894;2072.0365030260928;2052.1175894365415;2064.752229732434;2072.5440403111293;2076.0761461149796;2102.3062389411457;1960.2746983616082;1967.7048442733633;1982.048616664002;2002.8397728181783;2003.5091402606308;2077.9584408311825;2083.624947509448;2086.3740877736695;2086.645270304052;2089.8641588296787;2058.279602139254;2074;2091.9163233470645;2095.5704080663427;2100.56938327644;5714.885702285973;6958.930410695879;6966.512344135913;6975.232724400312;6990.370866621977;3652.525171727685;4219.97890010548;4259.74441533509;4271.103068355649;4284.507281662586;2691.035544052833;2726.972730272692;2737.835729856215;2778.9722102778915;2786.3730660601404;832.995835020827;859.1194026123211;860.7503823891064;887.6538150121457;911.2300106410139;9618.470984095871;9758.316917815755;9775.706728798148;9782.315237933348;9783.217342612645;4078.4494093297617;4108.404281379183;4153.605407486284;4158.376243563429;4172.040430700956;8482.745517634481;8484.40609157353;8485.109063548362;8496.830063398698;8503.829923401498;4463.598276155161;4472.753998530112;4477.462704475419;4496.078303947683;4497.055618320124;4027.81874815634;4036.253293140778;4045.3931910213705;4048.6963477739287;4054.3310353791885;3285.983570082134;3326.9500957485657;3330.0842268375904;3333.4999750037687;3373.7638365314683;1091.1925175370327;1092.595739576346;1094.3871431998107;1098.9505472253768;1099.7855418193535;1045.0698877998586;1057.735566108473;1158.6350299655583;1179.6140524492826;1193.9283642981275;6552.3775241352;6608.173978252718;6681.498887583353;6725.798226053226;6750.088738020402;414.2729509710439;420.340066096226;424.103022108245;426.0541597653267;426.96584273258065;4577.038821847449;5397.78408863641;5454;5460.481254280837;5464.18037294409;7171.103612048494;8157.061937877102;8176.713815016446;8298.585070746438;8594.355423343275;8297.668093276323;8345;8362.832743345221;8369.288610468057;8391.160883911682;6248.375162483715;6482.157319548429;6521.706523206467;6576.44100251484;6612.371824676648;6757.695903684445;6776.322367763184;6786.660666966731;6801.9319806801295;6808.829779255559;7409.259074092548;7693.846123077619;7714.228577142241;7740.187280335484;7774.533527988338;7039.472039596948;7189.496735228484;7225.205227424874;7388.445866559922;7396.778096657109;6142.508599312134;6190.41191086846;6221.657808820377;6268.749250029948;6305.211848518935;6878.65606719672;6911.930880691129;6916.930830691628;6947.861042779217;6954.443644508528;6416.422521973045;6424.550281480251;6482.546221764431;6663.833404164935;6746.0555522227905;6440.0983862260255;6468.15913931186;6470.5147113965695;6517.027404174318;6527.2167339919515;6581.80254592363;6582.473402127723;6641.900371494528;6657.500687448364;6671.733130674913;5801.6519008859605;5916.645001299936;6014.72933717975;6016.608920420159;6100.389961003864;6118.296395914527;6138.294096178818;6164.321924588202;6181.289151747606;6182.845428864134 09:28:57 INFO - 2015-11-19 09:28:57,542 DEBUG : BROWSER_OUTPUT: |4;prototype.html;313.4436375433605;318.4983650750069;319.6340190481898;321.8809040654958;326.4580795878842;5361.571074314055;5442.5101740843265;5444.537214336781;5454.509094181523;5514.9043363521805;5388.811391601294;5408;5413.106837371829;5414.242006119146;5415.862668839539;4019.457373254617;4109.116539943911;4132.772697501636;4246.278132717445;4246.681498887596;4200.3699445083175;4208.3687446882905;4221.641160501361;4223.64099051581;4233.301505251645;4164.208800327943;4172.687048471362;4177.895552611179;4185.079282557833;4185.225733239346;3981.9601803982023;4073.4704488416464;4113.095119073799;4182.91634167318;4194.832206711728;3668.614795446493;3669.5229620149476;3677.9632203678157;3683.0608194910396;3694.538182727159;5188.792448302102;5189.3772747270195;5190.662606930538;5193.065248255312;5204.583633309327;4804.879878003043;4809.903801923977;4818.10864989978;4818.542238487338;4819.373481447389;5561.360443549003;5664.150377443375;5685.545156387479;5716.371199168088;5717.885642287131;3906.726529142961;3908.687305015592;3910.393888947218;3911;3914.412838074283;5959.880802383928;6037.124616930564;6040.154378387029;6043.063325184604;6044.365341639153;4072.572379900127;4079.326911059701;4082.1835632873544;4084.223997440477;4091.304478238647;3995.420664003703;4143.482064741907;4165.021220013295;4169.45797046382;4175.331946888483;4787.712737235777;4792.880177995508;4796;4796.328514008042;4797.56821886032;5757.251557297608;5757.539396848326;5757.769689212385;5760.654360738369;5768.855778605568;1450.891183161246;1463.3049301581664;1471.4996901053694;1472.124086168728;1474.609228554434;980.2501086668705;985.1478471122571;987.8814542254976;993.1161266472845;1007.3301254665565;5013.573846223039;5016.996600679879;5018.974905125451;5021.949780502221;5023.321851550067;5919.112133180058;5922.111683247547;5923.496502797224;5924.940750592526;5925.881482370329;5007.774650140753;5011.5489605935645;5012.8496145115705;5014.949850501448;5021.271915572222;3024.0474250610987;3071.4010767900045;3171.3340198558562;3171.39743448744;3188.4260833050275;5616.073347897551;5647.519960803378;5653;5653.943460565424;5655.943440565624;6130.570860039755;6135.141080248769;6141.539384546177;6144.078388241799;6153.96923015391;5496.615236933456;5642.069058605366;5642.915356269659;5647.463490968352;5669.3480249770155;5942.7920022799;5943.1679564861815;5952.702364881825;5957.910631340446;5961.195238642727;5788.160716696139;5796.391378905154;5807.651540907559;5843.181954526454;5861.267341582302;5539.385788820031;5651.773929042956;5653.971730141323;5660.405657405913;5667;4040.1111755413763;4105.774182419996;4108.506979162519;4112.794360282034;4118.176364727006;5945.256842894638;5951.851203719942;5958;5959.523238140851;5963.373845746134;5723.456271654186;5724.112762521816;5730.799422020209;5731.369549349485;5736.512396446182;5560.638558493685;5710.200571919851;5719.342275638355;5724.313082430135;5727.455891690282;5587.022271102622;5589.888202235851;5592.105263157875;5598.832035038955;5599.384067752462;5726.055200891973;5751.051076572318;5767.596268261349;5772.278465191851;5775.566832487664;5502.119660854244;5548.9722551386985;5578.051731205786;5597.160425936142;5603.131514615241 09:28:57 INFO - 2015-11-19 09:28:57,544 DEBUG : BROWSER_OUTPUT: |5;yui.html;640.7276907314391;761.177927837935;779.3920741821381;781.1602527283172;805.7341077444444;11803.527858885645;12044.69888252794;12127.939360303208;12194.451249693762;12213.755724885508;12276;12352.258864468138;12355.382230888465;12358.629241122759;12372.257664540133;609.9908501372483;616.6146158650844;767.6123557603403;778.9727359542417;785.5129819511882;793.1750978981852;795.2246559604397;798.7683571764181;801.8075661841145;802.5545822068749;837.4389159263278;841.5623875584693;841.8989721233461;843.3421930893912;844.1010324004945;633.8288662061241;641.6374748267237;807.5195258820992;820.409305300183;821.6220538552274;608.1759216261989;608.3976862905691;608.8295277322356;610.4597431273311;610.7343305662051;11904.642860714106;12105.09211809109;12114;12116.697082572919;12132.211406258564;11392;11640.767184656344;11757.823632645517;12027.27836329823;12257.387130643432;9526.666566670203;9558.522073896278;9648.179904708108;9751.3661611995;9854;3257.96742032579;3260.8206548639814;3322.850471728778;3326.06870076379;3393.423118069934;41265.79367103145;41371.37942930828;41378.37932431016;41390.37914431286;41468.585314146774;9250.259979201648;9550.42697438142;9555.761105972406;9650.903490965;9682.322237443312;15727.606809829616;15732;15756.212189390713;15772;15787.447439339569;6371.74513019474;6557.442617377576;6654.168228971379;6708.731650734014;6802.591844489347;3434.9656503435144;3439.7076248519156;3440.174358154025;3482.867504377257;3592.604813470516;2796.203082121586;2829.8160619560076;2831.3912508810295;2842.943141137207;2848.458792829356;395.68147641148573;400.3974019101234;400.48137661728134;402.17353338888864;406.50609509445576;472.4802717011329;516.0401652925556;543.7553101104519;585.7494249776757;596.4810614765182;7806.18035106317;8368.916310836814;8765.422223999742;8874.334424918157;9109.590068446936;460.4796579864731;464.8768076459741;471.92685133804315;574.0614095953147;579.643519235667;3546.556680414948;3631.418494829319;3701.8889433317045;3732.776033437948;3734.2718169957143;54354.184687229725;55039.724801375734;55171.448285517436;55275.170872436946;55401.445985540435;46051.5394846054;46327;46806.29790553144;46942.295865562046;48063.519364806605;43364;43471.13057738828;43519.34720979188;43576.78211608922;44476.332855007204;8185.754427367188;8266.13205613402;8307.127751586238;8434.831303373776;8721.869171962298;33537.47856475035;33684;33745.3250934975;34313.313733725685;34498.137546561535;39705.80147099246;39719.40420893747;41349;42456.36315455209;42928.35607465953;6704.631245281556;6710.819861950544;6734.6632668367365;6741.831454213488;7084.0082388464625;11094.334339939629;11270.492827822603;11308.604198853001;11368.54525818958;11606.071514278668;10742.24804263694;10836.512356944115;11154.888451115385;11333.093352531943;11534.769304614028;10855.728606784893;11171.106311495223;11356.148288878201;11502.597409090642;11573.363465009168;8138.918610814053;9847.60609575609;10698.679039628823;10742.24804263694;10764.977327153907;9231.907680923374;9334.439933603733;9341.953290233505;9928.205743540355;9994.150497207818;8442.197991190827;8524.403291769517;8549.358798090292;8660.870086948575;8799.47203167812 09:28:57 INFO - 2015-11-19 09:28:57,544 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:28:57 INFO - 2015-11-19 09:28:57,544 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:28:57 INFO - 2015-11-19 09:28:57,544 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1022 09:28:57 INFO - 2015-11-19 09:28:57,544 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:28:57 INFO - 2015-11-19 09:28:57,544 DEBUG : BROWSER_OUTPUT: __startTimestamp1447954137532__endTimestamp 09:28:57 INFO - 2015-11-19 09:28:57,544 DEBUG : BROWSER_OUTPUT: 09:28:57 INFO - 2015-11-19 09:28:57,545 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:28:57 INFO - 2015-11-19 09:28:57,545 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:28:57 INFO - 2015-11-19 09:28:57,545 DEBUG : BROWSER_OUTPUT: 09:28:57 INFO - 2015-11-19 09:28:57,545 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4764.86 Median:4883.05 stddev:508.47 (10.4%) stddev-sans-first:481.04 09:28:57 INFO - 2015-11-19 09:28:57,546 DEBUG : BROWSER_OUTPUT: Values: 2607.5 2720.1 2731.4 2747.3 2754.0 4653.4 4777.5 4798.6 4819.0 4835.9 4727.3 4757.0 4825.3 4825.4 4853.2 4405.7 4430.2 4462.1 4481.3 4482.8 4202.6 4511.3 4537.4 4559.0 4564.2 4311.0 4388.1 4422.6 4446.6 4466.4 4448.5 4453.1 4462.8 4469.6 4497.8 4430.6 4438.2 4451.9 4461.7 4481.7 4588.1 4695.5 4698.6 4714.8 4857.0 5081.6 5093.0 5093.1 5095.8 5096.0 5097.5 5105.3 5147.5 5252.4 5300.0 4858.8 4876.8 4879.4 4881.6 4932.1 5330.7 5374.9 5386.1 5395.4 5400.1 4887.9 4982.7 4991.5 4997.0 5116.5 5172.8 5194.0 5215.7 5223.2 5225.8 5157.1 5171.4 5173.8 5177.7 5207.6 4866.2 4964.0 4965.9 5025.2 5152.4 4331.7 4338.7 4371.5 4384.3 4407.5 3765.0 3775.9 3782.9 3807.3 3808.7 4282.6 4364.0 4376.0 4384.8 4480.8 5168.6 5177.6 5187.8 5189.4 5221.8 4416.9 4425.1 4427.1 4433.2 4447.1 4508.8 4527.4 4622.4 4624.2 4637.0 4948.3 4952.4 4959.6 4960.2 4964.3 5228.5 5230.7 5230.9 5233.1 5270.3 4745.5 4846.5 4860.5 4950.3 5002.6 5121.8 5184.8 5188.8 5192.2 5235.8 5240.2 5263.1 5286.3 5289.5 5335.8 4764.3 4883.0 4884.4 5075.5 5089.8 4909.5 4990.7 4999.0 5025.8 5039.5 4911.4 4942.6 4966.4 4974.3 5021.7 4832.6 4909.1 5085.1 5093.0 5154.5 4821.7 4865.6 4894.4 4923.0 4947.6 09:28:57 INFO - 2015-11-19 09:28:57,546 DEBUG : BROWSER_OUTPUT: 09:28:57 INFO - 2015-11-19 09:28:57,546 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38791.55 Median:16071.67 stddev:59554.11 (370.6%) stddev-sans-first:59651.99 09:28:57 INFO - 2015-11-19 09:28:57,547 DEBUG : BROWSER_OUTPUT: Values: 558.0 569.2 570.4 572.7 582.1 27964.4 28482.7 37593.9 38240.4 38249.4 40985.6 41204.8 41455.2 41563.0 41635.2 7050.3 8003.7 8087.2 8179.3 8182.3 7131.8 7224.7 7234.4 7234.6 10013.4 10235.5 10338.5 10344.9 10355.7 10357.6 10190.8 10304.9 10307.7 10310.1 10320.7 7208.3 7384.4 10194.9 10619.7 10620.9 37827.4 38109.2 38233.6 38287.0 38406.0 2807.4 2859.5 2907.1 3005.4 3335.4 28503.9 28681.8 28770.4 29050.0 29249.6 2969.1 3017.6 3020.9 3068.8 3102.5 229969.0 230186.0 231094.0 231415.0 232219.0 52163.5 56040.4 56058.2 56545.4 56574.1 48198.3 65965.0 67655.3 67778.0 67785.0 12706.3 12805.9 12816.2 12833.9 12878.2 10312.2 10362.9 10384.3 10387.0 10387.8 18907.9 19048.2 19083.5 19134.0 19206.1 7131.7 7392.9 7401.2 7417.9 7443.4 838.5 847.3 908.6 966.7 1001.8 26095.5 26421.0 26867.2 26944.7 26954.0 942.8 943.5 949.1 1002.3 1003.5 12868.5 13945.2 14485.3 14712.1 14729.6 255444.0 263992.0 264102.0 270568.0 271707.0 46104.8 46274.5 46342.0 46444.5 46502.5 1234.3 1238.5 1246.0 1246.9 1252.1 20919.5 26158.7 27011.2 27298.6 27421.3 38093.2 38490.0 38515.6 38551.6 38594.2 180336.0 181119.0 181346.0 181601.0 182284.0 24436.1 24524.9 24849.3 26131.6 26495.0 27579.6 27842.6 27856.2 37419.6 37751.6 28789.3 29634.3 30077.0 30262.7 30489.7 30164.4 30369.7 30389.7 30437.4 30438.8 30053.2 30054.5 30328.7 30513.5 30517.0 28355.4 29236.3 29824.0 29970.1 30202.5 22977.0 23781.0 24894.3 25058.4 25343.7 09:28:57 INFO - 2015-11-19 09:28:57,547 DEBUG : BROWSER_OUTPUT: 09:28:57 INFO - 2015-11-19 09:28:57,547 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23974.31 Median:403.07 stddev:74943.38 (18593.3%) stddev-sans-first:75132.61 09:28:57 INFO - 2015-11-19 09:28:57,547 DEBUG : BROWSER_OUTPUT: Values: 341.5 343.4 343.9 344.0 346.4 12646.7 13072.2 15256.0 15475.0 16695.7 12704.3 15252.7 15697.3 15781.4 15794.0 4880.9 5069.6 5086.7 5091.9 5097.9 3590.5 3708.4 5090.3 5131.6 5139.5 5579.7 5699.6 5744.2 5751.6 5751.8 5516.5 5588.1 5590.6 5701.5 5711.5 4834.5 4848.1 4848.9 4850.0 4867.4 19019.0 19084.7 19304.4 19324.0 19875.5 1816.1 1821.4 1840.3 1904.6 1947.7 12665.2 12776.2 12887.2 13051.2 13381.2 1561.4 1587.2 1617.1 1627.2 1718.9 53797.0 55852.4 56208.7 56712.0 56816.0 5993.5 6021.4 6022.5 6049.4 6059.3 6839.0 6846.0 6852.0 6852.5 6855.5 4692.0 4721.4 4736.4 4743.6 4785.3 4858.7 4906.3 4941.3 4982.6 4991.7 2820.6 2849.4 2850.9 2851.9 2855.7 960.0 1001.3 1009.2 1013.6 1063.8 363.4 366.7 369.1 382.1 412.5 9783.7 10427.7 10573.1 10738.6 10779.6 374.8 383.6 400.1 402.6 403.6 5560.8 5980.3 6367.8 6514.4 6529.9 444292.0 458474.0 460749.0 460754.0 461057.0 69403.7 71239.6 71356.0 72098.3 72237.0 474.3 481.4 483.9 484.2 484.8 9384.9 9591.9 9872.6 10642.2 10666.7 30109.7 30220.4 30994.4 31379.0 31391.7 38783.4 39018.4 39331.2 39523.2 39877.8 5477.6 5556.7 5560.2 5617.5 5626.0 11066.8 11305.2 11332.3 11371.6 11616.5 10075.2 10188.2 10350.7 10383.3 10394.9 9791.8 10112.2 10162.1 10188.4 10315.2 8378.2 10237.9 10430.2 10443.8 10528.5 5198.4 5605.6 5654.4 5669.5 5706.3 9747.4 9941.8 10033.9 10094.2 10153.1 09:28:57 INFO - 2015-11-19 09:28:57,547 DEBUG : BROWSER_OUTPUT: 09:28:57 INFO - 2015-11-19 09:28:57,547 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4950.06 Median:6161.40 stddev:2557.21 (41.5%) stddev-sans-first:2550.76 09:28:57 INFO - 2015-11-19 09:28:57,547 DEBUG : BROWSER_OUTPUT: Values: 1437.8 1598.6 1647.9 1669.5 1675.1 6020.2 6158.5 6608.6 6789.5 6804.6 6966.9 6981.7 7008.1 7017.5 7033.9 2046.1 2059.7 2067.7 2071.3 2072.0 2052.1 2064.8 2072.5 2076.1 2102.3 1960.3 1967.7 1982.0 2002.8 2003.5 2078.0 2083.6 2086.4 2086.6 2089.9 2058.3 2074.0 2091.9 2095.6 2100.6 5714.9 6958.9 6966.5 6975.2 6990.4 3652.5 4220.0 4259.7 4271.1 4284.5 2691.0 2727.0 2737.8 2779.0 2786.4 833.0 859.1 860.8 887.7 911.2 9618.5 9758.3 9775.7 9782.3 9783.2 4078.4 4108.4 4153.6 4158.4 4172.0 8482.7 8484.4 8485.1 8496.8 8503.8 4463.6 4472.8 4477.5 4496.1 4497.1 4027.8 4036.3 4045.4 4048.7 4054.3 3286.0 3327.0 3330.1 3333.5 3373.8 1091.2 1092.6 1094.4 1099.0 1099.8 1045.1 1057.7 1158.6 1179.6 1193.9 6552.4 6608.2 6681.5 6725.8 6750.1 414.3 420.3 424.1 426.1 427.0 4577.0 5397.8 5454.0 5460.5 5464.2 7171.1 8157.1 8176.7 8298.6 8594.4 8297.7 8345.0 8362.8 8369.3 8391.2 6248.4 6482.2 6521.7 6576.4 6612.4 6757.7 6776.3 6786.7 6801.9 6808.8 7409.3 7693.8 7714.2 7740.2 7774.5 7039.5 7189.5 7225.2 7388.4 7396.8 6142.5 6190.4 6221.7 6268.7 6305.2 6878.7 6911.9 6916.9 6947.9 6954.4 6416.4 6424.6 6482.5 6663.8 6746.1 6440.1 6468.2 6470.5 6517.0 6527.2 6581.8 6582.5 6641.9 6657.5 6671.7 5801.7 5916.6 6014.7 6016.6 6100.4 6118.3 6138.3 6164.3 6181.3 6182.8 09:28:57 INFO - 2015-11-19 09:28:57,548 DEBUG : BROWSER_OUTPUT: 09:28:57 INFO - 2015-11-19 09:28:57,548 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4739.46 Median:5415.05 stddev:1402.16 (25.9%) stddev-sans-first:1366.18 09:28:57 INFO - 2015-11-19 09:28:57,549 DEBUG : BROWSER_OUTPUT: Values: 313.4 318.5 319.6 321.9 326.5 5361.6 5442.5 5444.5 5454.5 5514.9 5388.8 5408.0 5413.1 5414.2 5415.9 4019.5 4109.1 4132.8 4246.3 4246.7 4200.4 4208.4 4221.6 4223.6 4233.3 4164.2 4172.7 4177.9 4185.1 4185.2 3982.0 4073.5 4113.1 4182.9 4194.8 3668.6 3669.5 3678.0 3683.1 3694.5 5188.8 5189.4 5190.7 5193.1 5204.6 4804.9 4809.9 4818.1 4818.5 4819.4 5561.4 5664.2 5685.5 5716.4 5717.9 3906.7 3908.7 3910.4 3911.0 3914.4 5959.9 6037.1 6040.2 6043.1 6044.4 4072.6 4079.3 4082.2 4084.2 4091.3 3995.4 4143.5 4165.0 4169.5 4175.3 4787.7 4792.9 4796.0 4796.3 4797.6 5757.3 5757.5 5757.8 5760.7 5768.9 1450.9 1463.3 1471.5 1472.1 1474.6 980.3 985.1 987.9 993.1 1007.3 5013.6 5017.0 5019.0 5021.9 5023.3 5919.1 5922.1 5923.5 5924.9 5925.9 5007.8 5011.5 5012.8 5014.9 5021.3 3024.0 3071.4 3171.3 3171.4 3188.4 5616.1 5647.5 5653.0 5653.9 5655.9 6130.6 6135.1 6141.5 6144.1 6154.0 5496.6 5642.1 5642.9 5647.5 5669.3 5942.8 5943.2 5952.7 5957.9 5961.2 5788.2 5796.4 5807.7 5843.2 5861.3 5539.4 5651.8 5654.0 5660.4 5667.0 4040.1 4105.8 4108.5 4112.8 4118.2 5945.3 5951.9 5958.0 5959.5 5963.4 5723.5 5724.1 5730.8 5731.4 5736.5 5560.6 5710.2 5719.3 5724.3 5727.5 5587.0 5589.9 5592.1 5598.8 5599.4 5726.1 5751.1 5767.6 5772.3 5775.6 5502.1 5549.0 5578.1 5597.2 5603.1 09:28:57 INFO - 2015-11-19 09:28:57,549 DEBUG : BROWSER_OUTPUT: 09:28:57 INFO - 2015-11-19 09:28:57,549 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12692.43 Median:23395.94 stddev:14804.73 (63.3%) stddev-sans-first:14818.60 09:28:57 INFO - 2015-11-19 09:28:57,549 DEBUG : BROWSER_OUTPUT: Values: 640.7 761.2 779.4 781.2 805.7 11803.5 12044.7 12127.9 12194.5 12213.8 12276.0 12352.3 12355.4 12358.6 12372.3 610.0 616.6 767.6 779.0 785.5 793.2 795.2 798.8 801.8 802.6 837.4 841.6 841.9 843.3 844.1 633.8 641.6 807.5 820.4 821.6 608.2 608.4 608.8 610.5 610.7 11904.6 12105.1 12114.0 12116.7 12132.2 11392.0 11640.8 11757.8 12027.3 12257.4 9526.7 9558.5 9648.2 9751.4 9854.0 3258.0 3260.8 3322.9 3326.1 3393.4 41265.8 41371.4 41378.4 41390.4 41468.6 9250.3 9550.4 9555.8 9650.9 9682.3 15727.6 15732.0 15756.2 15772.0 15787.4 6371.7 6557.4 6654.2 6708.7 6802.6 3435.0 3439.7 3440.2 3482.9 3592.6 2796.2 2829.8 2831.4 2842.9 2848.5 395.7 400.4 400.5 402.2 406.5 472.5 516.0 543.8 585.7 596.5 7806.2 8368.9 8765.4 8874.3 9109.6 460.5 464.9 471.9 574.1 579.6 3546.6 3631.4 3701.9 3732.8 3734.3 54354.2 55039.7 55171.4 55275.2 55401.4 46051.5 46327.0 46806.3 46942.3 48063.5 43364.0 43471.1 43519.3 43576.8 44476.3 8185.8 8266.1 8307.1 8434.8 8721.9 33537.5 33684.0 33745.3 34313.3 34498.1 39705.8 39719.4 41349.0 42456.4 42928.4 6704.6 6710.8 6734.7 6741.8 7084.0 11094.3 11270.5 11308.6 11368.5 11606.1 10742.2 10836.5 11154.9 11333.1 11534.8 10855.7 11171.1 11356.1 11502.6 11573.4 8138.9 9847.6 10698.7 10742.2 10765.0 9231.9 9334.4 9342.0 9928.2 9994.2 8442.2 8524.4 8549.4 8660.9 8799.5 09:28:57 INFO - 2015-11-19 09:28:57,549 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:28:57 INFO - 2015-11-19 09:28:57,549 DEBUG : BROWSER_OUTPUT: 09:28:58 INFO - 2015-11-19 09:28:58,230 INFO : Browser exited with error code: 0 09:28:58 INFO - 2015-11-19 09:28:58,246 INFO : Completed test dromaeo_css (00:18:38) 09:28:58 INFO - 2015-11-19 09:28:58,246 INFO : Starting test kraken 09:28:58 INFO - 2015-11-19 09:28:58,246 DEBUG : operating with platform_type : linux_ 09:28:58 INFO - 2015-11-19 09:28:58,247 INFO : Initialising browser for kraken test... 09:28:58 INFO - 2015-11-19 09:28:58,253 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNssWS8/profile http://localhost:40497/getInfo.html 09:29:02 INFO - 2015-11-19 09:29:02,119 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:29:02 INFO - 2015-11-19 09:29:02,119 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:29:02 INFO - 2015-11-19 09:29:02,120 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:29:02 INFO - 2015-11-19 09:29:02,120 DEBUG : BROWSER_OUTPUT: __metrics 09:29:02 INFO - 2015-11-19 09:29:02,256 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:29:03 INFO - 2015-11-19 09:29:03,421 INFO : Browser initialized. 09:29:03 INFO - 2015-11-19 09:29:03,422 INFO : Running cycle 1/1 for kraken test... 09:29:03 INFO - 2015-11-19 09:29:03,422 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNssWS8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:29:15 INFO - 2015-11-19 09:29:15,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 141426688 09:29:15 INFO - 2015-11-19 09:29:15,295 DEBUG : BROWSER_OUTPUT: 09:29:17 INFO - 2015-11-19 09:29:17,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40497/tests/kraken/driver.html?testName=audio-beat-detection) 09:29:18 INFO - 2015-11-19 09:29:18,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 176893952 09:29:18 INFO - 2015-11-19 09:29:18,507 DEBUG : BROWSER_OUTPUT: 09:29:21 INFO - 2015-11-19 09:29:21,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40497/tests/kraken/driver.html?testName=audio-dft) 09:29:21 INFO - 2015-11-19 09:29:21,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 166547456 09:29:21 INFO - 2015-11-19 09:29:21,790 DEBUG : BROWSER_OUTPUT: 09:29:24 INFO - 2015-11-19 09:29:24,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40497/tests/kraken/driver.html?testName=audio-fft) 09:29:25 INFO - 2015-11-19 09:29:25,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 153079808 09:29:25 INFO - 2015-11-19 09:29:25,387 DEBUG : BROWSER_OUTPUT: 09:29:27 INFO - 2015-11-19 09:29:27,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40497/tests/kraken/driver.html?testName=audio-oscillator) 09:29:28 INFO - 2015-11-19 09:29:28,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 155037696 09:29:28 INFO - 2015-11-19 09:29:28,005 DEBUG : BROWSER_OUTPUT: 09:29:30 INFO - 2015-11-19 09:29:30,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40497/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:29:30 INFO - 2015-11-19 09:29:30,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 155131904 09:29:30 INFO - 2015-11-19 09:29:30,809 DEBUG : BROWSER_OUTPUT: 09:29:33 INFO - 2015-11-19 09:29:33,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40497/tests/kraken/driver.html?testName=imaging-darkroom) 09:29:34 INFO - 2015-11-19 09:29:34,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 155967488 09:29:34 INFO - 2015-11-19 09:29:34,360 DEBUG : BROWSER_OUTPUT: 09:29:37 INFO - 2015-11-19 09:29:37,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40497/tests/kraken/driver.html?testName=imaging-desaturate) 09:29:38 INFO - 2015-11-19 09:29:38,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 157446144 09:29:38 INFO - 2015-11-19 09:29:38,329 DEBUG : BROWSER_OUTPUT: 09:29:41 INFO - 2015-11-19 09:29:41,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40497/tests/kraken/driver.html?testName=json-parse-financial) 09:29:41 INFO - 2015-11-19 09:29:41,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 157917184 09:29:41 INFO - 2015-11-19 09:29:41,814 DEBUG : BROWSER_OUTPUT: 09:29:43 INFO - 2015-11-19 09:29:43,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40497/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:29:44 INFO - 2015-11-19 09:29:44,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 162402304 09:29:44 INFO - 2015-11-19 09:29:44,124 DEBUG : BROWSER_OUTPUT: 09:29:46 INFO - 2015-11-19 09:29:46,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40497/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:29:46 INFO - 2015-11-19 09:29:46,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 162803712 09:29:46 INFO - 2015-11-19 09:29:46,618 DEBUG : BROWSER_OUTPUT: 09:29:48 INFO - 2015-11-19 09:29:48,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40497/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:29:49 INFO - 2015-11-19 09:29:49,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 171220992 09:29:49 INFO - 2015-11-19 09:29:49,319 DEBUG : BROWSER_OUTPUT: 09:29:51 INFO - 2015-11-19 09:29:51,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:29:52 INFO - 2015-11-19 09:29:52,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 179363840 09:29:52 INFO - 2015-11-19 09:29:52,480 DEBUG : BROWSER_OUTPUT: 09:29:55 INFO - 2015-11-19 09:29:55,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:29:55 INFO - 2015-11-19 09:29:55,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 178307072 09:29:55 INFO - 2015-11-19 09:29:55,690 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40497/tests/kraken/driver.html?testName=ai-astar) 09:29:57 INFO - 2015-11-19 09:29:57,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 237961216 09:29:57 INFO - 2015-11-19 09:29:57,690 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,694 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:29:57 INFO - 2015-11-19 09:29:57,694 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:29:57 INFO - 2015-11-19 09:29:57,694 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:29:57 INFO - 2015-11-19 09:29:57,694 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:29:57 INFO - 2015-11-19 09:29:57,695 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;105;111;111;112;101;111;104;111 09:29:57 INFO - 2015-11-19 09:29:57,695 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;134;155;167;131;155;153;133;168;132 09:29:57 INFO - 2015-11-19 09:29:57,695 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;162;161;161;163;161;161;162 09:29:57 INFO - 2015-11-19 09:29:57,695 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;88;92;73;72;73;103;88;72 09:29:57 INFO - 2015-11-19 09:29:57,695 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;131;91;92;92;130;91;91;125 09:29:57 INFO - 2015-11-19 09:29:57,696 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;110;109;109;110;110 09:29:57 INFO - 2015-11-19 09:29:57,696 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;147;146;147;147;147;147;146 09:29:57 INFO - 2015-11-19 09:29:57,696 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;96;95;96;95;95 09:29:57 INFO - 2015-11-19 09:29:57,696 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;71;69;70;71;70;70;79;67;67 09:29:57 INFO - 2015-11-19 09:29:57,696 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;70;69;68;69;68;68 09:29:57 INFO - 2015-11-19 09:29:57,696 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;82;84;83;85;83;85;84;85;84 09:29:57 INFO - 2015-11-19 09:29:57,696 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;126;120;133;119;128;128;128;138;122 09:29:57 INFO - 2015-11-19 09:29:57,697 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;149;146;147;152;135;149;144;144;137 09:29:57 INFO - 2015-11-19 09:29:57,697 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;69;69;72;69;68;69;69;69 09:29:57 INFO - 2015-11-19 09:29:57,697 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:29:57 INFO - 2015-11-19 09:29:57,697 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:29:57 INFO - 2015-11-19 09:29:57,697 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,986 09:29:57 INFO - 2015-11-19 09:29:57,697 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:29:57 INFO - 2015-11-19 09:29:57,697 DEBUG : BROWSER_OUTPUT: __startTimestamp1447954197692__endTimestamp 09:29:57 INFO - 2015-11-19 09:29:57,697 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,701 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:29:57 INFO - 2015-11-19 09:29:57,701 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:29:57 INFO - 2015-11-19 09:29:57,701 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,701 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:3.94 (3.5%) stddev-sans-first:4.15 09:29:57 INFO - 2015-11-19 09:29:57,701 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 105.0 111.0 111.0 112.0 101.0 111.0 104.0 111.0 09:29:57 INFO - 2015-11-19 09:29:57,701 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,701 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.50 Median:155.00 stddev:14.64 (9.4%) stddev-sans-first:15.20 09:29:57 INFO - 2015-11-19 09:29:57,701 DEBUG : BROWSER_OUTPUT: Values: 157.0 134.0 155.0 167.0 131.0 155.0 153.0 133.0 168.0 132.0 09:29:57 INFO - 2015-11-19 09:29:57,701 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,701 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 09:29:57 INFO - 2015-11-19 09:29:57,701 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 162.0 161.0 161.0 163.0 161.0 161.0 162.0 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:73.00 stddev:11.16 (15.3%) stddev-sans-first:11.48 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 88.0 92.0 73.0 72.0 73.0 103.0 88.0 72.0 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.60 Median:91.00 stddev:18.06 (19.8%) stddev-sans-first:18.74 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 131.0 91.0 92.0 92.0 130.0 91.0 91.0 125.0 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 110.0 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 09:29:57 INFO - 2015-11-19 09:29:57,702 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.30 Median:70.00 stddev:3.37 (4.8%) stddev-sans-first:3.54 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 69.0 70.0 71.0 70.0 70.0 79.0 67.0 67.0 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 70.0 69.0 68.0 69.0 68.0 68.0 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: Values: 84.0 82.0 84.0 83.0 85.0 83.0 85.0 84.0 85.0 84.0 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:128.00 stddev:5.76 (4.5%) stddev-sans-first:6.11 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: Values: 127.0 126.0 120.0 133.0 119.0 128.0 128.0 128.0 138.0 122.0 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:146.50 stddev:5.42 (3.7%) stddev-sans-first:5.61 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: Values: 141.0 149.0 146.0 147.0 152.0 135.0 149.0 144.0 144.0 137.0 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: 09:29:57 INFO - 2015-11-19 09:29:57,703 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 09:29:57 INFO - 2015-11-19 09:29:57,704 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 69.0 72.0 69.0 68.0 69.0 69.0 69.0 09:29:57 INFO - 2015-11-19 09:29:57,704 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:29:57 INFO - 2015-11-19 09:29:57,704 DEBUG : BROWSER_OUTPUT: 09:29:58 INFO - 2015-11-19 09:29:58,610 INFO : Browser exited with error code: 0 09:29:58 INFO - 2015-11-19 09:29:58,661 INFO : Completed test kraken (00:01:00) 09:29:58 INFO - 2015-11-19 09:29:58,661 INFO : Starting test v8_7 09:29:58 INFO - 2015-11-19 09:29:58,661 DEBUG : operating with platform_type : linux_ 09:29:58 INFO - 2015-11-19 09:29:58,662 INFO : Initialising browser for v8_7 test... 09:29:58 INFO - 2015-11-19 09:29:58,668 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe1t4AI/profile http://localhost:40497/getInfo.html 09:30:02 INFO - 2015-11-19 09:30:02,605 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:30:02 INFO - 2015-11-19 09:30:02,605 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:30:02 INFO - 2015-11-19 09:30:02,605 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:30:02 INFO - 2015-11-19 09:30:02,605 DEBUG : BROWSER_OUTPUT: __metrics 09:30:02 INFO - 2015-11-19 09:30:02,721 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:30:03 INFO - 2015-11-19 09:30:03,886 INFO : Browser initialized. 09:30:03 INFO - 2015-11-19 09:30:03,887 INFO : Running cycle 1/1 for v8_7 test... 09:30:03 INFO - 2015-11-19 09:30:03,887 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe1t4AI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:30:15 INFO - 2015-11-19 09:30:15,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 140881920 09:30:15 INFO - 2015-11-19 09:30:15,732 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40497/tests/v8_7/run.html (next: http://localhost:40497/tests/v8_7/run.html) 09:30:37 INFO - 2015-11-19 09:30:37,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 441278464 09:30:37 INFO - 2015-11-19 09:30:37,388 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,388 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:30:37 INFO - 2015-11-19 09:30:37,388 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:30:37 INFO - 2015-11-19 09:30:37,388 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:30:37 INFO - 2015-11-19 09:30:37,389 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:30:37 INFO - 2015-11-19 09:30:37,389 DEBUG : BROWSER_OUTPUT: |0;Richards;162.78691193228065 09:30:37 INFO - 2015-11-19 09:30:37,389 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.64430816404752 09:30:37 INFO - 2015-11-19 09:30:37,389 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.6420581655481 09:30:37 INFO - 2015-11-19 09:30:37,389 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5070.707070707071 09:30:37 INFO - 2015-11-19 09:30:37,390 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1984.126984126984 09:30:37 INFO - 2015-11-19 09:30:37,390 DEBUG : BROWSER_OUTPUT: |5;Earley;803.8585209003215 09:30:37 INFO - 2015-11-19 09:30:37,390 DEBUG : BROWSER_OUTPUT: |6;Boyer;12382.716049382716 09:30:37 INFO - 2015-11-19 09:30:37,390 DEBUG : BROWSER_OUTPUT: |7;RegExp;27216.216216216217 09:30:37 INFO - 2015-11-19 09:30:37,391 DEBUG : BROWSER_OUTPUT: |8;Splay;625 09:30:37 INFO - 2015-11-19 09:30:37,391 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4859.223300970873 09:30:37 INFO - 2015-11-19 09:30:37,391 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:30:37 INFO - 2015-11-19 09:30:37,392 DEBUG : BROWSER_OUTPUT: __startTimestamp1447954237382__endTimestamp 09:30:37 INFO - 2015-11-19 09:30:37,392 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,392 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:30:37 INFO - 2015-11-19 09:30:37,392 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:30:37 INFO - 2015-11-19 09:30:37,393 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,393 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.79 Median:162.79 stddev:0.00 (0.0%) 09:30:37 INFO - 2015-11-19 09:30:37,393 DEBUG : BROWSER_OUTPUT: Values: 162.8 09:30:37 INFO - 2015-11-19 09:30:37,393 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,393 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.64 Median:191.64 stddev:0.00 (0.0%) 09:30:37 INFO - 2015-11-19 09:30:37,394 DEBUG : BROWSER_OUTPUT: Values: 191.6 09:30:37 INFO - 2015-11-19 09:30:37,394 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,394 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 09:30:37 INFO - 2015-11-19 09:30:37,394 DEBUG : BROWSER_OUTPUT: Values: 279.6 09:30:37 INFO - 2015-11-19 09:30:37,394 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,394 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5070.71 Median:5070.71 stddev:0.00 (0.0%) 09:30:37 INFO - 2015-11-19 09:30:37,395 DEBUG : BROWSER_OUTPUT: Values: 5070.7 09:30:37 INFO - 2015-11-19 09:30:37,395 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,395 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 09:30:37 INFO - 2015-11-19 09:30:37,395 DEBUG : BROWSER_OUTPUT: Values: 1984.1 09:30:37 INFO - 2015-11-19 09:30:37,395 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,395 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:803.86 Median:803.86 stddev:0.00 (0.0%) 09:30:37 INFO - 2015-11-19 09:30:37,395 DEBUG : BROWSER_OUTPUT: Values: 803.9 09:30:37 INFO - 2015-11-19 09:30:37,395 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,395 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 09:30:37 INFO - 2015-11-19 09:30:37,395 DEBUG : BROWSER_OUTPUT: Values: 12382.7 09:30:37 INFO - 2015-11-19 09:30:37,396 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,396 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27216.22 Median:27216.22 stddev:0.00 (0.0%) 09:30:37 INFO - 2015-11-19 09:30:37,396 DEBUG : BROWSER_OUTPUT: Values: 27216.2 09:30:37 INFO - 2015-11-19 09:30:37,396 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,396 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:625.00 Median:625.00 stddev:0.00 (0.0%) 09:30:37 INFO - 2015-11-19 09:30:37,396 DEBUG : BROWSER_OUTPUT: Values: 625.0 09:30:37 INFO - 2015-11-19 09:30:37,396 DEBUG : BROWSER_OUTPUT: 09:30:37 INFO - 2015-11-19 09:30:37,396 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 09:30:37 INFO - 2015-11-19 09:30:37,397 DEBUG : BROWSER_OUTPUT: Values: 4859.2 09:30:37 INFO - 2015-11-19 09:30:37,397 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:30:37 INFO - 2015-11-19 09:30:37,397 DEBUG : BROWSER_OUTPUT: 09:30:38 INFO - 2015-11-19 09:30:38,286 INFO : Browser exited with error code: 0 09:30:38 INFO - 2015-11-19 09:30:38,305 INFO : Completed test v8_7 (00:00:39) 09:30:38 INFO - 2015-11-19 09:30:38,402 INFO : Completed test suite (00:20:18) 09:30:38 INFO - 2015-11-19 09:30:38,402 DEBUG : Working with test: dromaeo_css 09:30:38 INFO - 2015-11-19 09:30:38,402 DEBUG : Generating results file: dromaeo_css 09:30:38 INFO - 2015-11-19 09:30:38,403 DEBUG : Working with test: kraken 09:30:38 INFO - 2015-11-19 09:30:38,403 DEBUG : Generating results file: kraken 09:30:38 INFO - 2015-11-19 09:30:38,404 INFO : javascript benchmark 09:30:38 INFO - 2015-11-19 09:30:38,404 DEBUG : Working with test: v8_7 09:30:38 INFO - 2015-11-19 09:30:38,404 DEBUG : Generating results file: v8_7 09:30:38 INFO - 2015-11-19 09:30:38,404 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:30:38 INFO - 2015-11-19 09:30:38,464 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 09:30:38 INFO - 2015-11-19 09:30:38,464 DEBUG : process_Request line: dromaeo_css 6082.43 graph.html#tests=[[72,203,35]] 09:30:38 INFO - 2015-11-19 09:30:38,464 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:30:38 INFO - 2015-11-19 09:30:38,494 DEBUG : process_Request line: kraken 1516.50 graph.html#tests=[[232,203,35]] 09:30:38 INFO - 2015-11-19 09:30:38,494 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:30:38 INFO - 2015-11-19 09:30:38,599 DEBUG : process_Request line: v8_7 19659.64 graph.html#tests=[[230,203,35]] 09:30:38 INFO - 2015-11-19 09:30:38,600 INFO : javascript benchmark 09:30:38 INFO - 2015-11-19 09:30:38,604 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2607.4654695787367, 2720.061578755329, 2731.399092199718, 2747.3131717070733, 2753.9999999999995, 4653.3717948077, 4777.498362671921, 4798.640101992351, 4818.975905120474, 4835.854924352267, 4727.267273572593, 4756.977249891282, 4825.252085926687, 4825.372701548802, 4853.1506986277345, 4405.735655860651, 4430.246858034142, 4462.062966776981, 4481.327800829869, 4482.753448560328, 4202.621764041236, 4511.255642818947, 4537.4328208973875, 4558.954410455886, 4564.2012647786505, 4310.956890431118, 4388.1004394099455, 4422.646188304928, 4446.622037126832, 4466.3747075409465, 4448.532904045061, 4453.064856380164, 4462.776861156929, 4469.575390337913, 4497.7526236057, 4430.579094985971, 4438.245498265303, 4451.888702782457, 4461.70116631828, 4481.686281960264, 4588.128255631419, 4695.5069717679835, 4698.553637404441, 4714.787834547454, 4856.975715121437, 5081.59347252219, 5092.9745351273, 5093.057784309877, 5095.770690318945, 5096.031753966735, 5097.46476619957, 5105.285260063594, 5147.48525147486, 5252.422233554306, 5300.01949639318, 4858.78135483904, 4876.780544875418, 4879.414470263556, 4881.609471242292, 4932.136876046678, 5330.680159190461, 5374.8656283592445, 5386.057439947994, 5395.379531353866, 5400.135978243541, 4887.902241955141, 4982.701037937735, 4991.5258050485145, 4996.950030499721, 5116.513931176532, 5172.844814655491, 5194.0, 5215.739213039333, 5223.216517522402, 5225.790968361299, 5157.123289040872, 5171.3535808024, 5173.844784656391, 5177.663451875616, 5207.557357624644, 4866.221404575251, 4963.950360496421, 4965.90068198634, 5025.246213068069, 5152.355955505562, 4331.740095594275, 4338.739675619409, 4371.540988196257, 4384.254676704904, 4407.471103467605, 3764.962350376516, 3775.8867233983024, 3782.867599634, 3807.2956503047026, 3808.6762625176616, 4282.63597594208, 4363.956360436418, 4375.978120109443, 4384.802683879233, 4480.843170489017, 5168.586513078944, 5177.58579313654, 5187.818426355059, 5189.351331083614, 5221.791128354899, 4416.933745993812, 4425.09285596452, 4427.092446048552, 4433.246348120827, 4447.110577884436, 4508.774561271924, 4527.388802511618, 4622.375979242759, 4624.213883639789, 4637.0, 4948.331975183304, 4952.380952380952, 4959.628027897994, 4960.181570040902, 4964.255361695775, 5228.529432351107, 5230.7384630769075, 5230.921536176884, 5233.058049551118, 5270.314859068297, 4745.525447455227, 4846.466888642176, 4860.465348811557, 4950.257461380677, 5002.574781143498, 5121.795128194831, 5184.818531351385, 5188.844334669966, 5192.1952097424955, 5235.816746413857, 5240.187770895517, 5263.105272103828, 5286.286351342519, 5289.497497737709, 5335.786568537215, 4764.30917516965, 4883.047805677858, 4884.389451318585, 5075.543201111917, 5089.796408143633, 4909.533594308535, 4990.72551009698, 4998.950010499849, 5025.824096156617, 5039.521245481674, 4911.386076740408, 4942.604591632733, 4966.428860681068, 4974.278729584263, 5021.698698078127, 4832.589229915497, 4909.116359055404, 5085.084684756632, 5093.0, 5154.484551544815, 4821.734804585782, 4865.610751139971, 4894.388201474816, 4923.0, 4947.554720075211], "unit": "ms", "name": "dojo.html", "value": 4732.383758000287}, {"lowerIsBetter": false, "replicates": [558.0, 569.1604882797872, 570.426721145249, 572.6592677356974, 582.1471544187764, 27964.440711185765, 28482.715172848264, 37593.9323337216, 38240.42639360405, 38249.426258606145, 40985.59014409863, 41204.79397603015, 41455.17089658205, 41563.0, 41635.16729665405, 7050.29497050296, 8003.719869804543, 8087.191280871895, 8179.263866252036, 8182.345412367026, 7131.821704457404, 7224.7471338503165, 7234.42124630031, 7234.60209688467, 10013.399196048224, 10235.539400726986, 10338.53476593555, 10344.948275258614, 10355.74110647236, 10357.637482688107, 10190.796184076315, 10304.896951030507, 10307.690769276935, 10310.072093511544, 10320.690379288633, 7208.315210055036, 7384.446166537531, 10194.949025254826, 10619.672540932383, 10620.946895265552, 37827.43258851092, 38109.23781524354, 38233.61766382329, 38287.0, 38406.0, 2807.355768991876, 2859.542473204298, 2907.069737683942, 3005.3989202159655, 3335.382954153489, 28503.85748071267, 28681.79190175242, 28770.42459150826, 29050.0, 29249.561256581168, 2969.138949704605, 3017.6077109975563, 3020.864061117255, 3068.769842261839, 3102.4570700127615, 229969.0, 230186.0, 231094.0, 231415.0, 232219.0, 52163.47836521662, 56040.43959560434, 56058.159127613115, 56545.43454565402, 56574.07962885199, 48198.27702584464, 65965.0, 67655.32344676589, 67778.0, 67785.0, 12706.301153436465, 12805.935970320088, 12816.231026138461, 12833.935830320788, 12878.227306361649, 10312.175025997902, 10362.948185259176, 10384.32501887375, 10387.013233742933, 10387.792244155075, 18907.905460472608, 19048.238070477302, 19083.522911927314, 19134.0, 19206.135723892457, 7131.71473141079, 7392.889106663297, 7401.185869554345, 7417.8887316689215, 7443.449764207463, 838.5094719589109, 847.3390755210945, 908.5638893331238, 966.7148191283588, 1001.84972254161, 26095.478090438464, 26421.0, 26867.193984180507, 26944.730552694615, 26954.0, 942.8067246214509, 943.4575119306427, 949.0888746803008, 1002.3434650304063, 1003.5132960514145, 12868.485260589472, 13945.16329020262, 14485.275736213147, 14712.117272963656, 14729.55811325662, 255444.0, 263992.0, 264102.0, 270568.0, 271707.0, 46104.7694761524, 46274.53725462702, 46342.0, 46444.535554644695, 46502.534974650494, 1234.2594443333928, 1238.4798384678456, 1245.9501619935281, 1246.9064820138526, 1252.085977236604, 20919.477013074797, 26158.73841261563, 27011.189664310103, 27298.590521141803, 27421.31446713848, 38093.238135236585, 38490.0, 38515.61484385232, 38551.6144838548, 38594.2281154381, 180336.0, 181119.0, 181346.0, 181601.0, 182284.0, 24436.14473493419, 24524.877375613007, 24849.254522364357, 26131.608025879246, 26495.0, 27579.586306205023, 27842.582361265002, 27856.16431507058, 37419.62580374161, 37751.62248377591, 28789.28026799347, 29634.259143521584, 30077.0, 30262.69737302599, 30489.695103048685, 30164.396712065198, 30369.696303036686, 30389.696103039572, 30437.391252175275, 30438.84780576083, 30053.24866878258, 30054.54918176273, 30328.696713032587, 30513.542296865122, 30517.0, 28355.43289134247, 29236.26909327199, 29824.0, 29970.100896973127, 30202.54696179515, 22977.0, 23781.0, 24894.253172404857, 25058.37354066163, 25343.74656253414], "unit": "ms", "name": "ext.html", "value": 16709.59420442973}, {"lowerIsBetter": false, "replicates": [341.520164169342, 343.4076218523048, 343.9071450708309, 344.0401280427608, 346.3523211594319, 12646.747065058693, 13072.215667059983, 15256.0, 15475.0, 16695.66608667826, 12704.301263430507, 15252.694946101072, 15697.29362178702, 15781.368745250176, 15794.0, 4880.926786098212, 5069.619778516608, 5086.745662716868, 5091.9236211456855, 5097.872553186163, 3590.46143078539, 3708.35103856824, 5090.287359769635, 5131.563817075553, 5139.48605139485, 5579.7489112990015, 5699.601027928046, 5744.224529688501, 5751.626144300628, 5751.7699292028265, 5516.531094856962, 5588.050031494615, 5590.552755779528, 5701.543876489871, 5711.514521265697, 4834.468208497063, 4848.127337079324, 4848.927266091011, 4849.951500484985, 4867.3915760529935, 19019.0, 19084.71372929407, 19304.42086737386, 19324.0, 19875.50311242216, 1816.1464111867401, 1821.3716267887557, 1840.300685739424, 1904.6381187574316, 1947.6981067934494, 12665.176763510342, 12776.233425994471, 12887.226766394046, 13051.21692698441, 13381.19712817234, 1561.4066654671153, 1587.246058122394, 1617.0944271208161, 1627.1620115640455, 1718.9226484808214, 53797.0, 55852.44147558513, 56208.71895640536, 56712.0, 56816.0, 5993.490553303018, 6021.42796434338, 6022.5483088768515, 6049.425304596057, 6059.303180134253, 6839.0425340452375, 6846.0, 6851.9657401712675, 6852.486063545254, 6855.485838562127, 4691.976540117277, 4721.386219791405, 4736.384270044872, 4743.573078422958, 4785.3300537924715, 4858.708477491362, 4906.31311616374, 4941.283513890466, 4982.60139188864, 4991.725455100004, 2820.5910143029146, 2849.3731379096566, 2850.857457127135, 2851.885924562994, 2855.6858745537975, 959.9664011759555, 1001.2890847498358, 1009.1926458833051, 1013.5844303835393, 1063.8085144673878, 363.38225017470404, 366.7402472506947, 369.10492056762246, 382.06584899919983, 412.45967782205406, 9783.657571985088, 10427.739306517245, 10573.101286390589, 10738.624148154933, 10779.568817247222, 374.83694592852197, 383.6361734035475, 400.055868151163, 402.5591976785415, 403.57221345373995, 5560.805371811967, 5980.252468441445, 6367.840803979845, 6514.413702766774, 6529.934700653028, 444292.0, 458474.0, 460749.0, 460754.0, 461057.0, 69403.65298173476, 71239.6438017817, 71356.0, 72098.27901721021, 72237.0, 474.26015415951224, 481.4367190387255, 483.8766114640744, 484.24941340922135, 484.8424262114827, 9384.906150938676, 9591.9040809591, 9872.605095796087, 10642.201834862572, 10666.679999600025, 30109.69890301069, 30220.395592087596, 30994.380112397175, 31379.0, 31391.686083138877, 38783.418248726855, 39018.414723778595, 39331.2133757329, 39523.20953580855, 39877.80061099676, 5477.616566840283, 5556.749946252509, 5560.165975103767, 5617.494425501724, 5626.043572592587, 11066.778664426827, 11305.208635395444, 11332.263402878787, 11371.601993930173, 11616.535338586362, 10075.193984481077, 10188.235882309005, 10350.689479315633, 10383.325083869524, 10394.948025259826, 9791.755206119904, 10112.241581881535, 10162.085412312632, 10188.388696678223, 10315.226358023028, 8378.162183781573, 10237.897621023993, 10430.217733670157, 10443.791124177626, 10528.473576321, 5198.376194856642, 5605.607607467438, 5654.378018418053, 5669.461401166883, 5706.343770466449, 9747.415155090717, 9941.801163976825, 10033.899661003588, 10094.24293178, 10153.136983356497], "unit": "ms", "name": "jquery.html", "value": 6527.599651817843}, {"lowerIsBetter": false, "replicates": [1437.7771445425963, 1598.5603958911297, 1647.9093649849253, 1669.540876259029, 1675.1121905390148, 6020.217371741673, 6158.476529494993, 6608.603483790976, 6789.4568434525245, 6804.557703749265, 6966.895496567556, 6981.685824137913, 7008.088948436696, 7017.543859649119, 7033.8944915826305, 2046.130394582304, 2059.70134330522, 2067.6588362920174, 2071.326818783894, 2072.0365030260928, 2052.1175894365415, 2064.752229732434, 2072.5440403111293, 2076.0761461149796, 2102.3062389411457, 1960.2746983616082, 1967.7048442733633, 1982.048616664002, 2002.8397728181783, 2003.5091402606308, 2077.9584408311825, 2083.624947509448, 2086.3740877736695, 2086.645270304052, 2089.8641588296787, 2058.279602139254, 2074.0, 2091.9163233470645, 2095.5704080663427, 2100.56938327644, 5714.885702285973, 6958.930410695879, 6966.512344135913, 6975.232724400312, 6990.370866621977, 3652.525171727685, 4219.97890010548, 4259.74441533509, 4271.103068355649, 4284.507281662586, 2691.035544052833, 2726.972730272692, 2737.835729856215, 2778.9722102778915, 2786.3730660601404, 832.995835020827, 859.1194026123211, 860.7503823891064, 887.6538150121457, 911.2300106410139, 9618.470984095871, 9758.316917815755, 9775.706728798148, 9782.315237933348, 9783.217342612645, 4078.4494093297617, 4108.404281379183, 4153.605407486284, 4158.376243563429, 4172.040430700956, 8482.745517634481, 8484.40609157353, 8485.109063548362, 8496.830063398698, 8503.829923401498, 4463.598276155161, 4472.753998530112, 4477.462704475419, 4496.078303947683, 4497.055618320124, 4027.81874815634, 4036.253293140778, 4045.3931910213705, 4048.6963477739287, 4054.3310353791885, 3285.983570082134, 3326.9500957485657, 3330.0842268375904, 3333.4999750037687, 3373.7638365314683, 1091.1925175370327, 1092.595739576346, 1094.3871431998107, 1098.9505472253768, 1099.7855418193535, 1045.0698877998586, 1057.735566108473, 1158.6350299655583, 1179.6140524492826, 1193.9283642981275, 6552.3775241352, 6608.173978252718, 6681.498887583353, 6725.798226053226, 6750.088738020402, 414.2729509710439, 420.340066096226, 424.103022108245, 426.0541597653267, 426.96584273258065, 4577.038821847449, 5397.78408863641, 5454.0, 5460.481254280837, 5464.18037294409, 7171.103612048494, 8157.061937877102, 8176.713815016446, 8298.585070746438, 8594.355423343275, 8297.668093276323, 8345.0, 8362.832743345221, 8369.288610468057, 8391.160883911682, 6248.375162483715, 6482.157319548429, 6521.706523206467, 6576.44100251484, 6612.371824676648, 6757.695903684445, 6776.322367763184, 6786.660666966731, 6801.9319806801295, 6808.829779255559, 7409.259074092548, 7693.846123077619, 7714.228577142241, 7740.187280335484, 7774.533527988338, 7039.472039596948, 7189.496735228484, 7225.205227424874, 7388.445866559922, 7396.778096657109, 6142.508599312134, 6190.41191086846, 6221.657808820377, 6268.749250029948, 6305.211848518935, 6878.65606719672, 6911.930880691129, 6916.930830691628, 6947.861042779217, 6954.443644508528, 6416.422521973045, 6424.550281480251, 6482.546221764431, 6663.833404164935, 6746.0555522227905, 6440.0983862260255, 6468.15913931186, 6470.5147113965695, 6517.027404174318, 6527.2167339919515, 6581.80254592363, 6582.473402127723, 6641.900371494528, 6657.500687448364, 6671.733130674913, 5801.6519008859605, 5916.645001299936, 6014.72933717975, 6016.608920420159, 6100.389961003864, 6118.296395914527, 6138.294096178818, 6164.321924588202, 6181.289151747606, 6182.845428864134], "unit": "ms", "name": "mootools.html", "value": 4005.840448400435}, {"lowerIsBetter": false, "replicates": [313.4436375433605, 318.4983650750069, 319.6340190481898, 321.8809040654958, 326.4580795878842, 5361.571074314055, 5442.5101740843265, 5444.537214336781, 5454.509094181523, 5514.9043363521805, 5388.811391601294, 5408.0, 5413.106837371829, 5414.242006119146, 5415.862668839539, 4019.457373254617, 4109.116539943911, 4132.772697501636, 4246.278132717445, 4246.681498887596, 4200.3699445083175, 4208.3687446882905, 4221.641160501361, 4223.64099051581, 4233.301505251645, 4164.208800327943, 4172.687048471362, 4177.895552611179, 4185.079282557833, 4185.225733239346, 3981.9601803982023, 4073.4704488416464, 4113.095119073799, 4182.91634167318, 4194.832206711728, 3668.614795446493, 3669.5229620149476, 3677.9632203678157, 3683.0608194910396, 3694.538182727159, 5188.792448302102, 5189.3772747270195, 5190.662606930538, 5193.065248255312, 5204.583633309327, 4804.879878003043, 4809.903801923977, 4818.10864989978, 4818.542238487338, 4819.373481447389, 5561.360443549003, 5664.150377443375, 5685.545156387479, 5716.371199168088, 5717.885642287131, 3906.726529142961, 3908.687305015592, 3910.393888947218, 3911.0, 3914.412838074283, 5959.880802383928, 6037.124616930564, 6040.154378387029, 6043.063325184604, 6044.365341639153, 4072.572379900127, 4079.326911059701, 4082.1835632873544, 4084.223997440477, 4091.304478238647, 3995.420664003703, 4143.482064741907, 4165.021220013295, 4169.45797046382, 4175.331946888483, 4787.712737235777, 4792.880177995508, 4796.0, 4796.328514008042, 4797.56821886032, 5757.251557297608, 5757.539396848326, 5757.769689212385, 5760.654360738369, 5768.855778605568, 1450.891183161246, 1463.3049301581664, 1471.4996901053694, 1472.124086168728, 1474.609228554434, 980.2501086668705, 985.1478471122571, 987.8814542254976, 993.1161266472845, 1007.3301254665565, 5013.573846223039, 5016.996600679879, 5018.974905125451, 5021.949780502221, 5023.321851550067, 5919.112133180058, 5922.111683247547, 5923.496502797224, 5924.940750592526, 5925.881482370329, 5007.774650140753, 5011.5489605935645, 5012.8496145115705, 5014.949850501448, 5021.271915572222, 3024.0474250610987, 3071.4010767900045, 3171.3340198558562, 3171.39743448744, 3188.4260833050275, 5616.073347897551, 5647.519960803378, 5653.0, 5653.943460565424, 5655.943440565624, 6130.570860039755, 6135.141080248769, 6141.539384546177, 6144.078388241799, 6153.96923015391, 5496.615236933456, 5642.069058605366, 5642.915356269659, 5647.463490968352, 5669.3480249770155, 5942.7920022799, 5943.1679564861815, 5952.702364881825, 5957.910631340446, 5961.195238642727, 5788.160716696139, 5796.391378905154, 5807.651540907559, 5843.181954526454, 5861.267341582302, 5539.385788820031, 5651.773929042956, 5653.971730141323, 5660.405657405913, 5667.0, 4040.1111755413763, 4105.774182419996, 4108.506979162519, 4112.794360282034, 4118.176364727006, 5945.256842894638, 5951.851203719942, 5958.0, 5959.523238140851, 5963.373845746134, 5723.456271654186, 5724.112762521816, 5730.799422020209, 5731.369549349485, 5736.512396446182, 5560.638558493685, 5710.200571919851, 5719.342275638355, 5724.313082430135, 5727.455891690282, 5587.022271102622, 5589.888202235851, 5592.105263157875, 5598.832035038955, 5599.384067752462, 5726.055200891973, 5751.051076572318, 5767.596268261349, 5772.278465191851, 5775.566832487664, 5502.119660854244, 5548.9722551386985, 5578.051731205786, 5597.160425936142, 5603.131514615241], "unit": "ms", "name": "prototype.html", "value": 4291.784266909012}, {"lowerIsBetter": false, "replicates": [640.7276907314391, 761.177927837935, 779.3920741821381, 781.1602527283172, 805.7341077444444, 11803.527858885645, 12044.69888252794, 12127.939360303208, 12194.451249693762, 12213.755724885508, 12276.0, 12352.258864468138, 12355.382230888465, 12358.629241122759, 12372.257664540133, 609.9908501372483, 616.6146158650844, 767.6123557603403, 778.9727359542417, 785.5129819511882, 793.1750978981852, 795.2246559604397, 798.7683571764181, 801.8075661841145, 802.5545822068749, 837.4389159263278, 841.5623875584693, 841.8989721233461, 843.3421930893912, 844.1010324004945, 633.8288662061241, 641.6374748267237, 807.5195258820992, 820.409305300183, 821.6220538552274, 608.1759216261989, 608.3976862905691, 608.8295277322356, 610.4597431273311, 610.7343305662051, 11904.642860714106, 12105.09211809109, 12114.0, 12116.697082572919, 12132.211406258564, 11392.0, 11640.767184656344, 11757.823632645517, 12027.27836329823, 12257.387130643432, 9526.666566670203, 9558.522073896278, 9648.179904708108, 9751.3661611995, 9854.0, 3257.96742032579, 3260.8206548639814, 3322.850471728778, 3326.06870076379, 3393.423118069934, 41265.79367103145, 41371.37942930828, 41378.37932431016, 41390.37914431286, 41468.585314146774, 9250.259979201648, 9550.42697438142, 9555.761105972406, 9650.903490965, 9682.322237443312, 15727.606809829616, 15732.0, 15756.212189390713, 15772.0, 15787.447439339569, 6371.74513019474, 6557.442617377576, 6654.168228971379, 6708.731650734014, 6802.591844489347, 3434.9656503435144, 3439.7076248519156, 3440.174358154025, 3482.867504377257, 3592.604813470516, 2796.203082121586, 2829.8160619560076, 2831.3912508810295, 2842.943141137207, 2848.458792829356, 395.68147641148573, 400.3974019101234, 400.48137661728134, 402.17353338888864, 406.50609509445576, 472.4802717011329, 516.0401652925556, 543.7553101104519, 585.7494249776757, 596.4810614765182, 7806.18035106317, 8368.916310836814, 8765.422223999742, 8874.334424918157, 9109.590068446936, 460.4796579864731, 464.8768076459741, 471.92685133804315, 574.0614095953147, 579.643519235667, 3546.556680414948, 3631.418494829319, 3701.8889433317045, 3732.776033437948, 3734.2718169957143, 54354.184687229725, 55039.724801375734, 55171.448285517436, 55275.170872436946, 55401.445985540435, 46051.5394846054, 46327.0, 46806.29790553144, 46942.295865562046, 48063.519364806605, 43364.0, 43471.13057738828, 43519.34720979188, 43576.78211608922, 44476.332855007204, 8185.754427367188, 8266.13205613402, 8307.127751586238, 8434.831303373776, 8721.869171962298, 33537.47856475035, 33684.0, 33745.3250934975, 34313.313733725685, 34498.137546561535, 39705.80147099246, 39719.40420893747, 41349.0, 42456.36315455209, 42928.35607465953, 6704.631245281556, 6710.819861950544, 6734.6632668367365, 6741.831454213488, 7084.0082388464625, 11094.334339939629, 11270.492827822603, 11308.604198853001, 11368.54525818958, 11606.071514278668, 10742.24804263694, 10836.512356944115, 11154.888451115385, 11333.093352531943, 11534.769304614028, 10855.728606784893, 11171.106311495223, 11356.148288878201, 11502.597409090642, 11573.363465009168, 8138.918610814053, 9847.60609575609, 10698.679039628823, 10742.24804263694, 10764.977327153907, 9231.907680923374, 9334.439933603733, 9341.953290233505, 9928.205743540355, 9994.150497207818, 8442.197991190827, 8524.403291769517, 8549.358798090292, 8660.870086948575, 8799.47203167812], "unit": "ms", "name": "yui.html", "value": 5705.441339969146}], "name": "dromaeo_css", "value": 6082.42772636399}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 111.0, 111.0, 112.0, 101.0, 111.0, 104.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [157.0, 134.0, 155.0, 167.0, 131.0, 155.0, 153.0, 133.0, 168.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 161.0, 163.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 88.0, 92.0, 73.0, 72.0, 73.0, 103.0, 88.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 131.0, 91.0, 92.0, 92.0, 130.0, 91.0, 91.0, 125.0], "unit": "ms", "name": "audio-oscillator", "value": 102.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 69.0, 70.0, 71.0, 70.0, 70.0, 79.0, 67.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 70.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 70.0, 69.0, 68.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 84.0, 83.0, 85.0, 83.0, 85.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [127.0, 126.0, 120.0, 133.0, 119.0, 128.0, 128.0, 128.0, 138.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [141.0, 149.0, 146.0, 147.0, 152.0, 135.0, 149.0, 144.0, 144.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 69.0, 72.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1516.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.78691193228065], "unit": "score", "name": "Richards", "value": 216.86018600000003}, {"lowerIsBetter": false, "replicates": [191.64430816404752], "unit": "score", "name": "DeltaBlue", "value": 345.00372400000015}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5070.707070707071], "unit": "score", "name": "Decrypt", "value": 52.493862549800795}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [803.8585209003215], "unit": "score", "name": "Earley", "value": 829.0799720000001}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [27216.216216216217], "unit": "score", "name": "RegExp", "value": 33.472140019860944}, {"lowerIsBetter": false, "replicates": [625.0], "unit": "score", "name": "Splay", "value": 130.3856}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 19659.637767757413}]} 09:30:38 INFO - RETURN: dromaeo_css: 6082.43 09:30:38 INFO - RETURN: kraken: 1516.50 09:30:38 INFO - RETURN: v8_7: 19659.64 09:30:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19659.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1516.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6082.43"}}} 09:30:38 INFO - Return code: 0 09:30:38 INFO - # TBPL SUCCESS # 09:30:38 INFO - Running post-action listener: _resource_record_post_action 09:30:38 INFO - Running post-run listener: _resource_record_post_run 09:30:39 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 521035776; Read time: 244; Write time: 518020 09:30:39 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 131907584; Read time: 0; Write time: 153584 09:30:39 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 343998464; Read time: 244; Write time: 349284 09:30:39 INFO - Running post-run listener: _upload_blobber_files 09:30:39 INFO - Blob upload gear active. 09:30:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:30:39 INFO - Copying logs to upload dir... 09:30:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1261.070782 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-19 09:30:39.721392) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:39.724522) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009951 build_url: 'https://queue.taskcluster.net/v1/task/0nMeCn8SRx6MiafmseEL7w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:39.776149) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:39.776491) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447952977.201618-72947130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:30:39.826061) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 09:30:39.826389) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 09:30:39.826682) ========= ========= Total master_lag: 0.22 =========