builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1448455897.63 results: success (0) buildid: 20151125033831 builduid: 4dae39946dce49039de1c92fcf52e411 revision: 1c35ad64bf2fd15addf258c3cc32d4da86fad5f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.629675) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.630074) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.630421) ========= 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=a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.007948 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.652720) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.653057) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.666857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.667171) ========= 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=a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004660 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.719998) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.720346) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.720735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.721060) ========= 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=a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 04:51: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2015-11-25 04:51:38 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201079 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.936298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:37.936582) ========= 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=a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014008 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:38.002744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 04:51:38.003092) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1c35ad64bf2fd15addf258c3cc32d4da86fad5f0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1c35ad64bf2fd15addf258c3cc32d4da86fad5f0 --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=a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 04:51:38,224 truncating revision to first 12 chars 2015-11-25 04:51:38,224 Setting DEBUG logging. 2015-11-25 04:51:38,224 attempt 1/10 2015-11-25 04:51:38,224 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1c35ad64bf2f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 04:51:39,087 unpacking tar archive at: mozilla-central-1c35ad64bf2f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.154007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 04:51:39.174867) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:39.175251) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:39.189547) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:39.189897) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 04:51:39.190357) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-25 04:51:39.190686) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:51:39 INFO - MultiFileLogger online at 20151125 04:51:39 in /builds/slave/test 04:51:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:51:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:51:39 INFO - {'append_to_log': False, 04:51:39 INFO - 'base_work_dir': '/builds/slave/test', 04:51:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:51:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:51:39 INFO - 'branch': 'Firefox-Non-PGO', 04:51:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:51:39 INFO - 'config_files': ('talos/linux_config.py',), 04:51:39 INFO - 'default_actions': ('clobber', 04:51:39 INFO - 'read-buildbot-config', 04:51:39 INFO - 'download-and-extract', 04:51:39 INFO - 'populate-webroot', 04:51:39 INFO - 'create-virtualenv', 04:51:39 INFO - 'install', 04:51:39 INFO - 'run-tests'), 04:51:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:51:39 INFO - 'download_minidump_stackwalk': True, 04:51:39 INFO - 'download_symbols': 'ondemand', 04:51:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:51:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:51:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:51:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:51:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:51:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:51:39 INFO - 'installer_path': 'installer.exe', 04:51:39 INFO - 'log_level': 'info', 04:51:39 INFO - 'log_name': 'talos', 04:51:39 INFO - 'log_to_console': True, 04:51:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:51:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:51:39 INFO - 'opt_config_files': (), 04:51:39 INFO - 'pip_index': False, 04:51:39 INFO - 'sps_profile': False, 04:51:39 INFO - 'sps_profile_interval': 0, 04:51:39 INFO - 'suite': 'dromaeojs', 04:51:39 INFO - 'system_bits': '64', 04:51:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:51:39 INFO - 'title': 'talos-linux64-ix-031', 04:51:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:51:39 INFO - 'use_talos_json': True, 04:51:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:51:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:51:39 INFO - 'work_dir': 'build'} 04:51:39 INFO - ##### 04:51:39 INFO - ##### Running clobber step. 04:51:39 INFO - ##### 04:51:39 INFO - Running pre-action listener: _resource_record_pre_action 04:51:39 INFO - Running main action method: clobber 04:51:39 INFO - rmtree: /builds/slave/test/build 04:51:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:51:39 INFO - Running post-action listener: _resource_record_post_action 04:51:39 INFO - ##### 04:51:39 INFO - ##### Running read-buildbot-config step. 04:51:39 INFO - ##### 04:51:39 INFO - Running pre-action listener: _resource_record_pre_action 04:51:39 INFO - Running main action method: read_buildbot_config 04:51:39 INFO - Using buildbot properties: 04:51:39 INFO - { 04:51:39 INFO - "properties": { 04:51:39 INFO - "buildnumber": 374, 04:51:39 INFO - "product": "firefox", 04:51:39 INFO - "script_repo_revision": "production", 04:51:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:51:39 INFO - "repository": "", 04:51:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:51:39 INFO - "buildid": "20151125033831", 04:51:39 INFO - "slavename": "talos-linux64-ix-031", 04:51:39 INFO - "pgo_build": "False", 04:51:39 INFO - "basedir": "/builds/slave/test", 04:51:39 INFO - "project": "", 04:51:39 INFO - "platform": "ubuntu64_hw", 04:51:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:51:39 INFO - "slavebuilddir": "test", 04:51:39 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:51:39 INFO - "branch": "mozilla-central", 04:51:39 INFO - "repo_path": "mozilla-central", 04:51:39 INFO - "stage_platform": "linux64", 04:51:39 INFO - "builduid": "4dae39946dce49039de1c92fcf52e411", 04:51:39 INFO - "revision": "1c35ad64bf2fd15addf258c3cc32d4da86fad5f0" 04:51:39 INFO - }, 04:51:39 INFO - "sourcestamp": { 04:51:39 INFO - "repository": "", 04:51:39 INFO - "hasPatch": false, 04:51:39 INFO - "project": "", 04:51:39 INFO - "branch": "mozilla-central-linux64-talos", 04:51:39 INFO - "changes": [ 04:51:39 INFO - { 04:51:39 INFO - "category": null, 04:51:39 INFO - "files": [ 04:51:39 INFO - { 04:51:39 INFO - "url": null, 04:51:39 INFO - "name": "https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:51:39 INFO - } 04:51:39 INFO - ], 04:51:39 INFO - "repository": "", 04:51:39 INFO - "rev": "1c35ad64bf2fd15addf258c3cc32d4da86fad5f0", 04:51:39 INFO - "who": "cbook@mozilla.com", 04:51:39 INFO - "when": 1448455857, 04:51:39 INFO - "number": 6705383, 04:51:39 INFO - "comments": "Backed out changeset 50441cd0d6a1 (bug 1212321) for causing regressions", 04:51:39 INFO - "project": "", 04:51:39 INFO - "at": "Wed 25 Nov 2015 04:50:57", 04:51:39 INFO - "branch": "mozilla-central-linux64-talos", 04:51:39 INFO - "revlink": "", 04:51:39 INFO - "properties": [ 04:51:39 INFO - [ 04:51:39 INFO - "buildid", 04:51:39 INFO - "20151125033831", 04:51:39 INFO - "Change" 04:51:39 INFO - ], 04:51:39 INFO - [ 04:51:39 INFO - "builduid", 04:51:39 INFO - "4dae39946dce49039de1c92fcf52e411", 04:51:39 INFO - "Change" 04:51:39 INFO - ], 04:51:39 INFO - [ 04:51:39 INFO - "pgo_build", 04:51:39 INFO - "False", 04:51:39 INFO - "Change" 04:51:39 INFO - ] 04:51:39 INFO - ], 04:51:39 INFO - "revision": "1c35ad64bf2fd15addf258c3cc32d4da86fad5f0" 04:51:39 INFO - } 04:51:39 INFO - ], 04:51:39 INFO - "revision": "1c35ad64bf2fd15addf258c3cc32d4da86fad5f0" 04:51:39 INFO - } 04:51:39 INFO - } 04:51:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:51:39 INFO - Running post-action listener: _resource_record_post_action 04:51:39 INFO - ##### 04:51:39 INFO - ##### Running download-and-extract step. 04:51:39 INFO - ##### 04:51:39 INFO - Running pre-action listener: _resource_record_pre_action 04:51:39 INFO - Running main action method: download_and_extract 04:51:39 INFO - mkdir: /builds/slave/test/build/tests 04:51: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')]} 04:51:39 INFO - https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/test_packages.json 04:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/test_packages.json 04:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:51:44 INFO - Downloaded 1302 bytes. 04:51:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:51:44 INFO - Using the following test package requirements: 04:51:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:51:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:44 INFO - u'jsshell-linux-x86_64.zip'], 04:51:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:51:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:51:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:51:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:51:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:51:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:51: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')]} 04:51:44 INFO - https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:51:49 INFO - Downloaded 21345501 bytes. 04:51:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:51:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:51:50 INFO - Return code: 0 04:51:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:51: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')]} 04:51:50 INFO - https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:51:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:51:51 INFO - Downloaded 21345501 bytes. 04:51:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:51:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:51:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:51:52 INFO - Return code: 0 04:51: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')]} 04:51:52 INFO - https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:51:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:51:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:51:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:51:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:51:54 INFO - Downloaded 11131717 bytes. 04:51:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:51:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:51:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:51:54 INFO - Return code: 0 04:51: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')]} 04:51:54 INFO - https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:51:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:51:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:51:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:51:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:51:55 INFO - Downloaded 56843949 bytes. 04:51:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:51:55 INFO - mkdir: /builds/slave/test/properties 04:51:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:51:55 INFO - Writing to file /builds/slave/test/properties/build_url 04:51:55 INFO - Contents: 04:51:55 INFO - build_url:https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:51:55 INFO - Running post-action listener: _resource_record_post_action 04:51:55 INFO - Running post-action listener: set_extra_try_arguments 04:51:55 INFO - ##### 04:51:55 INFO - ##### Running populate-webroot step. 04:51:55 INFO - ##### 04:51:55 INFO - Running pre-action listener: _resource_record_pre_action 04:51:55 INFO - Running main action method: populate_webroot 04:51:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:51:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:51:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:51:55 INFO - '../fennec_ids.txt'], 04:51:55 INFO - 'tests': ['tcheck2']}, 04:51:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:51:55 INFO - '--tppagecycles', 04:51:55 INFO - '7'], 04:51:55 INFO - 'tests': ['tsvgm']}}, 04:51:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:51:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:51:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:51:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:51:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:51:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:51:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'talos_options': ['--e10s'], 04:51:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:51:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'tests': ['damp', 'tps']}, 04:51:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'talos_options': ['--e10s'], 04:51:55 INFO - 'tests': ['damp', 'tps']}, 04:51:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:51:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:51:55 INFO - 'other': {'tests': ['a11yr', 04:51:55 INFO - 'ts_paint', 04:51:55 INFO - 'tpaint', 04:51:55 INFO - 'sessionrestore', 04:51:55 INFO - 'sessionrestore_no_auto_restore']}, 04:51:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:51:55 INFO - 'tests': ['a11yr', 04:51:55 INFO - 'ts_paint', 04:51:55 INFO - 'tpaint', 04:51:55 INFO - 'sessionrestore', 04:51:55 INFO - 'sessionrestore_no_auto_restore']}, 04:51:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:51:55 INFO - 'tests': ['a11yr', 04:51:55 INFO - 'ts_paint', 04:51:55 INFO - 'tpaint', 04:51:55 INFO - 'sessionrestore', 04:51:55 INFO - 'sessionrestore_no_auto_restore']}, 04:51:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:51:55 INFO - 'tests': ['a11yr', 04:51:55 INFO - 'ts_paint', 04:51:55 INFO - 'tpaint', 04:51:55 INFO - 'sessionrestore', 04:51:55 INFO - 'sessionrestore_no_auto_restore']}, 04:51:55 INFO - 'other_l64': {'tests': ['a11yr', 04:51:55 INFO - 'ts_paint', 04:51:55 INFO - 'tpaint', 04:51:55 INFO - 'sessionrestore', 04:51:55 INFO - 'sessionrestore_no_auto_restore']}, 04:51:55 INFO - 'other_nol64': {'tests': ['a11yr', 04:51:55 INFO - 'ts_paint', 04:51:55 INFO - 'tpaint', 04:51:55 INFO - 'sessionrestore', 04:51:55 INFO - 'sessionrestore_no_auto_restore']}, 04:51:55 INFO - 'svgr': {'tests': ['tsvgx', 04:51:55 INFO - 'tsvgr_opacity', 04:51:55 INFO - 'tart', 04:51:55 INFO - 'tscrollx', 04:51:55 INFO - 'cart']}, 04:51:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:51:55 INFO - 'tests': ['tsvgx', 04:51:55 INFO - 'tsvgr_opacity', 04:51:55 INFO - 'tart', 04:51:55 INFO - 'tscrollx', 04:51:55 INFO - 'cart']}, 04:51:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'tests': ['tp5o']}, 04:51:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'talos_options': ['--e10s'], 04:51:55 INFO - 'tests': ['tp5o']}, 04:51:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'talos_options': ['--xperf_path', 04:51:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:55 INFO - 'tests': ['tp5n']}, 04:51:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:51:55 INFO - 'talos_options': ['--e10s', 04:51:55 INFO - '--xperf_path', 04:51:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:51:55 INFO - 'tests': ['tp5n']}}, 04:51:55 INFO - 'talos.zip': {'path': '', 04:51:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:51:55 INFO - Running post-action listener: _resource_record_post_action 04:51:55 INFO - ##### 04:51:55 INFO - ##### Running create-virtualenv step. 04:51:55 INFO - ##### 04:51:55 INFO - Running pre-action listener: _resource_record_pre_action 04:51:55 INFO - Running main action method: create_virtualenv 04:51:55 INFO - Creating virtualenv /builds/slave/test/build/venv 04:51:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:51:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:51:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:51:56 INFO - Using real prefix '/usr' 04:51:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:51:56 INFO - Installing distribute.............................................................................................................................................................................................done. 04:51:58 INFO - Installing pip.................done. 04:51:58 INFO - Return code: 0 04:51:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:51: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')]} 04:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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')]} 04:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:58 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 0x1ccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efc210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e220>, '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 0x1efa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efa740>, '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': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:51:58 INFO - Using env: {'DISPLAY': ':0', 04:51:58 INFO - 'HOME': '/home/cltbld', 04:51:58 INFO - 'LANG': 'en_US.UTF-8', 04:51:58 INFO - 'LANGUAGE': 'en_US:en', 04:51:58 INFO - 'LOGNAME': 'cltbld', 04:51:58 INFO - 'MAIL': '/var/mail/cltbld', 04:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:58 INFO - 'MOZ_NO_REMOTE': '1', 04:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:58 INFO - 'NO_EM_RESTART': '1', 04:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:58 INFO - 'PWD': '/builds/slave/test', 04:51:58 INFO - 'SHELL': '/bin/bash', 04:51:58 INFO - 'SHLVL': '1', 04:51:58 INFO - 'TERM': 'linux', 04:51:58 INFO - 'TMOUT': '86400', 04:51:58 INFO - 'USER': 'cltbld', 04:51:58 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 04:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:58 INFO - '_': '/tools/buildbot/bin/python'} 04:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:51:58 INFO - Cleaning up... 04:51:58 INFO - Return code: 0 04:51:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:51: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')]} 04:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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')]} 04:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:58 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 0x1ccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efc210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e220>, '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 0x1efa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efa740>, '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': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:51:58 INFO - Using env: {'DISPLAY': ':0', 04:51:58 INFO - 'HOME': '/home/cltbld', 04:51:58 INFO - 'LANG': 'en_US.UTF-8', 04:51:58 INFO - 'LANGUAGE': 'en_US:en', 04:51:58 INFO - 'LOGNAME': 'cltbld', 04:51:58 INFO - 'MAIL': '/var/mail/cltbld', 04:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:58 INFO - 'MOZ_NO_REMOTE': '1', 04:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:58 INFO - 'NO_EM_RESTART': '1', 04:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:58 INFO - 'PWD': '/builds/slave/test', 04:51:58 INFO - 'SHELL': '/bin/bash', 04:51:58 INFO - 'SHLVL': '1', 04:51:58 INFO - 'TERM': 'linux', 04:51:58 INFO - 'TMOUT': '86400', 04:51:58 INFO - 'USER': 'cltbld', 04:51:58 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 04:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:58 INFO - '_': '/tools/buildbot/bin/python'} 04:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:58 INFO - Downloading/unpacking psutil>=0.7.1 04:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:52:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:00 INFO - Installing collected packages: psutil 04:52:00 INFO - Running setup.py install for psutil 04:52:00 INFO - building 'psutil._psutil_linux' extension 04:52:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:52:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:52:00 INFO - building 'psutil._psutil_posix' extension 04:52:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:52:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:52:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:01 INFO - Successfully installed psutil 04:52:01 INFO - Cleaning up... 04:52:01 INFO - Return code: 0 04:52:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efc210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e220>, '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 0x1efa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efa740>, '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': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:52:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:52:01 INFO - Using env: {'DISPLAY': ':0', 04:52:01 INFO - 'HOME': '/home/cltbld', 04:52:01 INFO - 'LANG': 'en_US.UTF-8', 04:52:01 INFO - 'LANGUAGE': 'en_US:en', 04:52:01 INFO - 'LOGNAME': 'cltbld', 04:52:01 INFO - 'MAIL': '/var/mail/cltbld', 04:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:01 INFO - 'MOZ_NO_REMOTE': '1', 04:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:01 INFO - 'NO_EM_RESTART': '1', 04:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:01 INFO - 'PWD': '/builds/slave/test', 04:52:01 INFO - 'SHELL': '/bin/bash', 04:52:01 INFO - 'SHLVL': '1', 04:52:01 INFO - 'TERM': 'linux', 04:52:01 INFO - 'TMOUT': '86400', 04:52:01 INFO - 'USER': 'cltbld', 04:52:01 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 04:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:01 INFO - '_': '/tools/buildbot/bin/python'} 04:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:52:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:52:03 INFO - Installing collected packages: mozsystemmonitor 04:52:03 INFO - Running setup.py install for mozsystemmonitor 04:52:03 INFO - Successfully installed mozsystemmonitor 04:52:03 INFO - Cleaning up... 04:52:03 INFO - Return code: 0 04:52:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:03 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 0x1ccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efc210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e220>, '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 0x1efa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efa740>, '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': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:52:03 INFO - Using env: {'DISPLAY': ':0', 04:52:03 INFO - 'HOME': '/home/cltbld', 04:52:03 INFO - 'LANG': 'en_US.UTF-8', 04:52:03 INFO - 'LANGUAGE': 'en_US:en', 04:52:03 INFO - 'LOGNAME': 'cltbld', 04:52:03 INFO - 'MAIL': '/var/mail/cltbld', 04:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:03 INFO - 'MOZ_NO_REMOTE': '1', 04:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:03 INFO - 'NO_EM_RESTART': '1', 04:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:03 INFO - 'PWD': '/builds/slave/test', 04:52:03 INFO - 'SHELL': '/bin/bash', 04:52:03 INFO - 'SHLVL': '1', 04:52:03 INFO - 'TERM': 'linux', 04:52:03 INFO - 'TMOUT': '86400', 04:52:03 INFO - 'USER': 'cltbld', 04:52:03 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 04:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:03 INFO - '_': '/tools/buildbot/bin/python'} 04:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:03 INFO - Downloading/unpacking blobuploader==1.2.4 04:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:52:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:05 INFO - Downloading docopt-0.6.1.tar.gz 04:52:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:05 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:05 INFO - Running setup.py install for blobuploader 04:52:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:52:05 INFO - Running setup.py install for requests 04:52:06 INFO - Running setup.py install for docopt 04:52:06 INFO - Successfully installed blobuploader requests docopt 04:52:06 INFO - Cleaning up... 04:52:06 INFO - Return code: 0 04:52:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:06 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 0x1ccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efc210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e220>, '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 0x1efa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efa740>, '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': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:06 INFO - Using env: {'DISPLAY': ':0', 04:52:06 INFO - 'HOME': '/home/cltbld', 04:52:06 INFO - 'LANG': 'en_US.UTF-8', 04:52:06 INFO - 'LANGUAGE': 'en_US:en', 04:52:06 INFO - 'LOGNAME': 'cltbld', 04:52:06 INFO - 'MAIL': '/var/mail/cltbld', 04:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:06 INFO - 'MOZ_NO_REMOTE': '1', 04:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:06 INFO - 'NO_EM_RESTART': '1', 04:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:06 INFO - 'PWD': '/builds/slave/test', 04:52:06 INFO - 'SHELL': '/bin/bash', 04:52:06 INFO - 'SHLVL': '1', 04:52:06 INFO - 'TERM': 'linux', 04:52:06 INFO - 'TMOUT': '86400', 04:52:06 INFO - 'USER': 'cltbld', 04:52:06 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 04:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:06 INFO - '_': '/tools/buildbot/bin/python'} 04:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:06 INFO - Running setup.py (path:/tmp/pip-4Tbw4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:06 INFO - Running setup.py (path:/tmp/pip-aeblAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:06 INFO - Running setup.py (path:/tmp/pip-DoYWag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:06 INFO - Running setup.py (path:/tmp/pip-mK90J1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:07 INFO - Running setup.py (path:/tmp/pip-NMbn2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:07 INFO - Running setup.py (path:/tmp/pip-8iAgcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:07 INFO - Running setup.py (path:/tmp/pip-H9J6VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:07 INFO - Running setup.py (path:/tmp/pip-KEXA9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:07 INFO - Running setup.py (path:/tmp/pip-BxIEgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:07 INFO - Running setup.py (path:/tmp/pip-vmOk1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:07 INFO - Running setup.py (path:/tmp/pip-_lxX3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:07 INFO - Running setup.py (path:/tmp/pip-zCWUmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:07 INFO - Running setup.py (path:/tmp/pip-U0Mm9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:07 INFO - Running setup.py (path:/tmp/pip-jDGTa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:07 INFO - Running setup.py (path:/tmp/pip-3kOY0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:07 INFO - Running setup.py (path:/tmp/pip-sGLRS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:07 INFO - Running setup.py (path:/tmp/pip-NfsohG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:07 INFO - Running setup.py install for manifestparser 04:52:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:52:08 INFO - Running setup.py install for mozcrash 04:52:08 INFO - Running setup.py install for mozdebug 04:52:08 INFO - Running setup.py install for mozdevice 04:52:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:52:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:52:08 INFO - Running setup.py install for mozfile 04:52:08 INFO - Running setup.py install for mozhttpd 04:52:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:52:08 INFO - Running setup.py install for mozinfo 04:52:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:52:08 INFO - Running setup.py install for mozInstall 04:52:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:52:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:52:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:52:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:52:08 INFO - Running setup.py install for mozleak 04:52:08 INFO - Running setup.py install for mozlog 04:52:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:52:08 INFO - Running setup.py install for moznetwork 04:52:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Running setup.py install for mozprocess 04:52:09 INFO - Running setup.py install for mozprofile 04:52:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Running setup.py install for mozrunner 04:52:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Running setup.py install for mozscreenshot 04:52:09 INFO - Running setup.py install for moztest 04:52:09 INFO - Running setup.py install for mozversion 04:52:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:52:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:09 INFO - Cleaning up... 04:52:09 INFO - Return code: 0 04:52:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:09 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 0x1ccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efc210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e220>, '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 0x1efa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efa740>, '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': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:09 INFO - Using env: {'DISPLAY': ':0', 04:52:09 INFO - 'HOME': '/home/cltbld', 04:52:09 INFO - 'LANG': 'en_US.UTF-8', 04:52:09 INFO - 'LANGUAGE': 'en_US:en', 04:52:09 INFO - 'LOGNAME': 'cltbld', 04:52:09 INFO - 'MAIL': '/var/mail/cltbld', 04:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:09 INFO - 'MOZ_NO_REMOTE': '1', 04:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:09 INFO - 'NO_EM_RESTART': '1', 04:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:09 INFO - 'PWD': '/builds/slave/test', 04:52:09 INFO - 'SHELL': '/bin/bash', 04:52:09 INFO - 'SHLVL': '1', 04:52:09 INFO - 'TERM': 'linux', 04:52:09 INFO - 'TMOUT': '86400', 04:52:09 INFO - 'USER': 'cltbld', 04:52:09 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 04:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:09 INFO - '_': '/tools/buildbot/bin/python'} 04:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:09 INFO - Running setup.py (path:/tmp/pip-eLBEE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:09 INFO - Running setup.py (path:/tmp/pip-o6njYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:10 INFO - Running setup.py (path:/tmp/pip-IdaDHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:10 INFO - Running setup.py (path:/tmp/pip-NzxF2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:10 INFO - Running setup.py (path:/tmp/pip-N_fAv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:10 INFO - Running setup.py (path:/tmp/pip-R5eNBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:10 INFO - Running setup.py (path:/tmp/pip-W75E9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:10 INFO - Running setup.py (path:/tmp/pip-zs77lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:10 INFO - Running setup.py (path:/tmp/pip-qZXwQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:10 INFO - Running setup.py (path:/tmp/pip-t21iKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:10 INFO - Running setup.py (path:/tmp/pip-MUhVRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:10 INFO - Running setup.py (path:/tmp/pip-u94loS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:10 INFO - Running setup.py (path:/tmp/pip-Epvvme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:10 INFO - Running setup.py (path:/tmp/pip-1E9nwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:10 INFO - Running setup.py (path:/tmp/pip-0jF3kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:10 INFO - Running setup.py (path:/tmp/pip-j4b4KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:11 INFO - Running setup.py (path:/tmp/pip-IaC5pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:12 INFO - Downloading blessings-1.5.1.tar.gz 04:52:12 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:52:12 INFO - Installing collected packages: blessings 04:52:12 INFO - Running setup.py install for blessings 04:52:12 INFO - Successfully installed blessings 04:52:12 INFO - Cleaning up... 04:52:13 INFO - Return code: 0 04:52:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:52:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:13 INFO - Reading from file tmpfile_stdout 04:52:13 INFO - Current package versions: 04:52:13 INFO - argparse == 1.2.1 04:52:13 INFO - blessings == 1.5.1 04:52:13 INFO - blobuploader == 1.2.4 04:52:13 INFO - docopt == 0.6.1 04:52:13 INFO - manifestparser == 1.1 04:52:13 INFO - mozInstall == 1.12 04:52:13 INFO - mozcrash == 0.16 04:52:13 INFO - mozdebug == 0.1 04:52:13 INFO - mozdevice == 0.47 04:52:13 INFO - mozfile == 1.2 04:52:13 INFO - mozhttpd == 0.7 04:52:13 INFO - mozinfo == 0.9 04:52:13 INFO - mozleak == 0.1 04:52:13 INFO - mozlog == 3.1 04:52:13 INFO - moznetwork == 0.27 04:52:13 INFO - mozprocess == 0.22 04:52:13 INFO - mozprofile == 0.27 04:52:13 INFO - mozrunner == 6.11 04:52:13 INFO - mozscreenshot == 0.1 04:52:13 INFO - mozsystemmonitor == 0.0 04:52:13 INFO - moztest == 0.7 04:52:13 INFO - mozversion == 1.4 04:52:13 INFO - psutil == 3.1.1 04:52:13 INFO - requests == 1.2.3 04:52:13 INFO - wsgiref == 0.1.2 04:52:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:13 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 0x1ccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efc210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e220>, '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 0x1efa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efa740>, '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': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:13 INFO - Using env: {'DISPLAY': ':0', 04:52:13 INFO - 'HOME': '/home/cltbld', 04:52:13 INFO - 'LANG': 'en_US.UTF-8', 04:52:13 INFO - 'LANGUAGE': 'en_US:en', 04:52:13 INFO - 'LOGNAME': 'cltbld', 04:52:13 INFO - 'MAIL': '/var/mail/cltbld', 04:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:13 INFO - 'MOZ_NO_REMOTE': '1', 04:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:13 INFO - 'NO_EM_RESTART': '1', 04:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:13 INFO - 'PWD': '/builds/slave/test', 04:52:13 INFO - 'SHELL': '/bin/bash', 04:52:13 INFO - 'SHLVL': '1', 04:52:13 INFO - 'TERM': 'linux', 04:52:13 INFO - 'TMOUT': '86400', 04:52:13 INFO - 'USER': 'cltbld', 04:52:13 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 04:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:13 INFO - '_': '/tools/buildbot/bin/python'} 04:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:52:13 INFO - Cleaning up... 04:52:13 INFO - Return code: 0 04:52:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efc210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e220>, '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 0x1efa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efa740>, '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': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:52:13 INFO - Using env: {'DISPLAY': ':0', 04:52:13 INFO - 'HOME': '/home/cltbld', 04:52:13 INFO - 'LANG': 'en_US.UTF-8', 04:52:13 INFO - 'LANGUAGE': 'en_US:en', 04:52:13 INFO - 'LOGNAME': 'cltbld', 04:52:13 INFO - 'MAIL': '/var/mail/cltbld', 04:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:13 INFO - 'MOZ_NO_REMOTE': '1', 04:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:13 INFO - 'NO_EM_RESTART': '1', 04:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:13 INFO - 'PWD': '/builds/slave/test', 04:52:13 INFO - 'SHELL': '/bin/bash', 04:52:13 INFO - 'SHLVL': '1', 04:52:13 INFO - 'TERM': 'linux', 04:52:13 INFO - 'TMOUT': '86400', 04:52:13 INFO - 'USER': 'cltbld', 04:52:13 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 04:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:13 INFO - '_': '/tools/buildbot/bin/python'} 04:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:13 INFO - Downloading/unpacking jsonschema 04:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:52:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:52:15 INFO - Downloading/unpacking functools32 (from jsonschema) 04:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:15 INFO - Downloading functools32-3.2.3-2.tar.gz 04:52:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:52:15 INFO - warning: no files found matching '*.txt' 04:52:15 INFO - no previously-included directories found matching 'build' 04:52:15 INFO - no previously-included directories found matching 'dist' 04:52:15 INFO - no previously-included directories found matching '.git*' 04:52:15 INFO - Installing collected packages: jsonschema, functools32 04:52:15 INFO - Running setup.py install for functools32 04:52:15 INFO - warning: no files found matching '*.txt' 04:52:15 INFO - no previously-included directories found matching 'build' 04:52:15 INFO - no previously-included directories found matching 'dist' 04:52:15 INFO - no previously-included directories found matching '.git*' 04:52:15 INFO - Successfully installed jsonschema functools32 04:52:15 INFO - Cleaning up... 04:52:15 INFO - Return code: 0 04:52:15 INFO - Running post-action listener: _resource_record_post_action 04:52:15 INFO - Running post-action listener: _start_resource_monitoring 04:52:15 INFO - Starting resource monitoring. 04:52:15 INFO - ##### 04:52:15 INFO - ##### Running install step. 04:52:15 INFO - ##### 04:52:15 INFO - Running pre-action listener: _resource_record_pre_action 04:52:15 INFO - Running main action method: install 04:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:16 INFO - Reading from file tmpfile_stdout 04:52:16 INFO - Detecting whether we're running mozinstall >=1.0... 04:52:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:52:16 INFO - Reading from file tmpfile_stdout 04:52:16 INFO - Output received: 04:52:16 INFO - Usage: mozinstall [options] installer 04:52:16 INFO - Options: 04:52:16 INFO - -h, --help show this help message and exit 04:52:16 INFO - -d DEST, --destination=DEST 04:52:16 INFO - Directory to install application into. [default: 04:52:16 INFO - "/builds/slave/test"] 04:52:16 INFO - --app=APP Application being installed. [default: firefox] 04:52:16 INFO - mkdir: /builds/slave/test/build/application 04:52:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:52:30 INFO - Reading from file tmpfile_stdout 04:52:30 INFO - Output received: 04:52:30 INFO - /builds/slave/test/build/application/firefox/firefox 04:52:30 INFO - Running post-action listener: _resource_record_post_action 04:52:30 INFO - ##### 04:52:30 INFO - ##### Running run-tests step. 04:52:30 INFO - ##### 04:52:30 INFO - Running pre-action listener: _resource_record_pre_action 04:52:30 INFO - Running main action method: run_tests 04:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:52:30 INFO - Python 2.7.3 04:52:30 INFO - Return code: 0 04:52:30 INFO - grabbing minidump binary from tooltool 04:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:30 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 0x1f8e220>, '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 0x1efa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efa740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:52:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:52:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:52:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:52:30 INFO - Return code: 0 04:52:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:52:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:52:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:52:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:52:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] in /builds/slave/test/build 04:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost 04:52:30 INFO - Using env: {'DISPLAY': ':0', 04:52:30 INFO - 'HOME': '/home/cltbld', 04:52:30 INFO - 'LANG': 'en_US.UTF-8', 04:52:30 INFO - 'LANGUAGE': 'en_US:en', 04:52:30 INFO - 'LOGNAME': 'cltbld', 04:52:30 INFO - 'MAIL': '/var/mail/cltbld', 04:52:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:52:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:30 INFO - 'MOZ_NO_REMOTE': '1', 04:52:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:30 INFO - 'NO_EM_RESTART': '1', 04:52:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:30 INFO - 'PWD': '/builds/slave/test', 04:52:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:52:30 INFO - 'SHELL': '/bin/bash', 04:52:30 INFO - 'SHLVL': '1', 04:52:30 INFO - 'TERM': 'linux', 04:52:30 INFO - 'TMOUT': '86400', 04:52:30 INFO - 'USER': 'cltbld', 04:52:30 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242', 04:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:30 INFO - '_': '/tools/buildbot/bin/python'} 04:52:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] with output_timeout 3600 04:52:30 INFO - mozversion INFO | application_buildid: 20151125033831 04:52:30 INFO - mozversion INFO | application_changeset: 1c35ad64bf2fd15addf258c3cc32d4da86fad5f0 04:52:30 INFO - mozversion INFO | application_display_name: Nightly 04:52:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:52:30 INFO - mozversion INFO | application_name: Firefox 04:52:30 INFO - mozversion INFO | application_remotingname: firefox 04:52:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:52:30 INFO - mozversion INFO | application_vendor: Mozilla 04:52:30 INFO - mozversion INFO | application_version: 45.0a1 04:52:30 INFO - mozversion INFO | platform_buildid: 20151125033831 04:52:30 INFO - mozversion INFO | platform_changeset: 1c35ad64bf2fd15addf258c3cc32d4da86fad5f0 04:52:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:52:30 INFO - mozversion INFO | platform_version: 45.0a1 04:52:30 INFO - 2015-11-25 04:52:30,732 DEBUG : using testdate: 1448455950 04:52:30 INFO - 2015-11-25 04:52:30,732 DEBUG : actual date: 1448455950 04:52:30 INFO - 2015-11-25 04:52:30,741 INFO : starting webserver on 'localhost:48880' 04:52:30 INFO - 2015-11-25 04:52:30,742 INFO : Starting test suite talos-linux64-ix-031 04:52:30 INFO - 2015-11-25 04:52:30,742 INFO : Starting test dromaeo_css 04:52:30 INFO - 2015-11-25 04:52:30,743 DEBUG : operating with platform_type : linux_ 04:52:30 INFO - 2015-11-25 04:52:30,743 INFO : Initialising browser for dromaeo_css test... 04:52:30 INFO - 2015-11-25 04:52:30,760 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyQ5vWk/profile http://localhost:48880/getInfo.html 04:52:34 INFO - 2015-11-25 04:52:34,733 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:52:34 INFO - 2015-11-25 04:52:34,734 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:52:34 INFO - 2015-11-25 04:52:34,734 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:52:34 INFO - 2015-11-25 04:52:34,734 DEBUG : BROWSER_OUTPUT: __metrics 04:52:34 INFO - 2015-11-25 04:52:34,891 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:52:36 INFO - 2015-11-25 04:52:36,029 INFO : Browser initialized. 04:52:36 INFO - 2015-11-25 04:52:36,029 INFO : Running cycle 1/1 for dromaeo_css test... 04:52:36 INFO - 2015-11-25 04:52:36,030 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyQ5vWk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:52:47 INFO - 2015-11-25 04:52:47,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 138551296 04:52:47 INFO - 2015-11-25 04:52:47,919 DEBUG : BROWSER_OUTPUT: 04:53:39 INFO - 2015-11-25 04:53:39,090 DEBUG : BROWSER_OUTPUT: 1448456019087 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:55:51 INFO - 2015-11-25 04:55:51,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48880/tests/dromaeo/cssquery-ext.html) 04:55:52 INFO - 2015-11-25 04:55:52,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 255332352 04:55:52 INFO - 2015-11-25 04:55:52,146 DEBUG : BROWSER_OUTPUT: 04:58:54 INFO - 2015-11-25 04:58:54,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/dromaeo/cssquery-ext.html (next: http://localhost:48880/tests/dromaeo/cssquery-jquery.html) 04:58:55 INFO - 2015-11-25 04:58:55,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 223543296 04:58:55 INFO - 2015-11-25 04:58:55,234 DEBUG : BROWSER_OUTPUT: 05:01:57 INFO - 2015-11-25 05:01:57,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48880/tests/dromaeo/cssquery-mootools.html) 05:01:57 INFO - 2015-11-25 05:01:57,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 211234816 05:01:57 INFO - 2015-11-25 05:01:57,876 DEBUG : BROWSER_OUTPUT: 05:04:59 INFO - 2015-11-25 05:04:59,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48880/tests/dromaeo/cssquery-prototype.html) 05:05:00 INFO - 2015-11-25 05:05:00,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 203317248 05:05:00 INFO - 2015-11-25 05:05:00,454 DEBUG : BROWSER_OUTPUT: 05:08:03 INFO - 2015-11-25 05:08:03,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48880/tests/dromaeo/cssquery-yui.html) 05:08:03 INFO - 2015-11-25 05:08:03,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 207958016 05:08:03 INFO - 2015-11-25 05:08:03,883 DEBUG : BROWSER_OUTPUT: 05:11:06 INFO - 2015-11-25 05:11:06,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/dromaeo/cssquery-yui.html (next: http://localhost:48880/tests/dromaeo/cssquery-dojo.html) 05:11:06 INFO - 2015-11-25 05:11:06,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 251838464 05:11:06 INFO - 2015-11-25 05:11:06,626 DEBUG : BROWSER_OUTPUT: 05:11:06 INFO - 2015-11-25 05:11:06,627 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:11:06 INFO - 2015-11-25 05:11:06,627 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:11:06 INFO - 2015-11-25 05:11:06,627 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:11:06 INFO - 2015-11-25 05:11:06,627 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:11:06 INFO - 2015-11-25 05:11:06,628 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2602.2193341997404;2686.2112148320366;2697.595360695894;2711.2408525612823;2719.2793909613943;4475.373447717322;4512.842050528228;4578.793954272058;4610.331501932222;4621.283701026342;4472.64218862491;4561.0193808331205;4573.26827707566;4577.153226653063;4577.977110114453;4262.3393374027;4315.654747620199;4323.135372925428;4338.175746608134;4352.325389564622;4093.6725061995116;4374.846880359188;4379.4963579188325;4392.231359512089;4411.845585404511;4198.307279298912;4246.787660616972;4254.149170165979;4263.5736426357425;4294.613484786384;4258.53156152823;4277.871663850089;4281.229378711831;4298.054428025829;4332.501762297345;4077.7145599808027;4180.143070670505;4248.362745588156;4276.401303817468;4309.504406993205;4446.355278484634;4496.662750293741;4590.632749380042;4610.838620648261;4636.86089417318;5005.3242812220615;5012.298278241049;5017.34774479319;5022.874428139289;5039.571636410909;4762.071396077767;4881.267809828519;5030.094582975063;5037.823676171316;5058.4435712071645;4551.431071116111;4597.793099310506;4659.534046595313;4679.415073115861;4728.101660684459;5099.668521546162;5115.923261151086;5118.488151184926;5118.59051275897;5152;4593.219152744042;4706.082313948816;4911.631627627942;4913.852584422401;4914.582260507826;4836.516348365135;4858.78135483904;4915.95084049155;4924.556789888928;4970.478099799541;4894.094592500399;4897.706137631753;4901.58336541398;4932.482089380635;4943.3573635427165;4730.455997560324;4852.223644216909;4880.414350277918;4888.902221955541;4931.408231012301;4022.678185745192;4028.194361127786;4122.670186385082;4140.171965606891;4143.19207754491;3598.3163198992106;3601.729870259741;3610.187707765732;3633.94549081764;3645.6901163400876;4271.9359209611885;4273.230818452646;4275.850345237902;4281.186574550826;4317.935230971538;4703.905921881612;4807.302941073524;4833.637477189225;4954.702717836869;5086.872828179251;4226.598473145046;4261.4673165854265;4264.125854199943;4266.0188156724125;4302.010537576312;4358.738475691469;4373.868783936487;4378.255696531597;4396.692231543825;4412.205802955499;4544.6818722689095;4581;4653.557911998287;4654.813807447799;4669.626429885533;4951.801927922987;4953.975230123826;4977.601293038901;4978.303037574815;5009.398872135367;4706.388169537938;4719.1977363847545;4719.929201062056;4722.36248106515;4769.499202583679;4634.281686338623;4695.600873925618;4733.290006499053;4748.572628463455;4838.491958344323;4895.559399654048;4960.305557222064;4963.230699241623;4966.155753521838;5008.724520151281;4801.879953001063;4820.734859582757;4822.059698358787;4823.083614113307;4872.4883887192755;4609.147307747943;4672.229082201398;4730.266808644528;4733.36099626546;4760.428748550196;4697.295405689174;4751.334813126096;4756.453007904135;4773.522647735337;4788.928166077581;4878.390201224847;4882.829100981448;4891.315215869852;4893.951060489349;4899.608031357411;4487.64098872096;4598.241290187216;4601.355810186509;4618.261078227468;4773.04539092176 05:11:06 INFO - 2015-11-25 05:11:06,628 DEBUG : BROWSER_OUTPUT: |1;ext.html;519.0035132545512;540.1870185371016;551.2282804074296;581.0818906128318;583.6702263221277;27852;28476.145715628514;36400.45399319012;36410;36489.99999999996;39985.60014399855;40500.59499405005;40503;40506.39240411396;40681.59318406815;6942.236354001056;7688.96155519223;7883.172266911978;7888.6844526219165;7895.565743884084;6923.134608173978;7007.509474336798;9862.260330475207;10089.64686235982;10098.29311948164;9694.079062489052;9828.262880283972;9847.950760246189;9861;9880;7039.964800176018;7220.530665506725;9857.802843943116;9978;9981.850272245922;10059.597616095347;10374.377537347707;10378.688639340831;10379.84430233547;10384.532696028697;37195;37849.43225851614;37904.81047594772;37936.43095353572;37960.81019594912;2880.74073333401;2945.882164713409;2966.9554956675665;3078.707522785332;3452.5511683480986;28186.15441536757;28371.716282837115;28402.857985710147;28438.715612844022;28810.85594572035;3318.2533929865585;3505.929881402383;3508.7543871928974;3517.66582174693;3629.4374371972385;213450;215380.99999999843;215399;215516;215632;50146.749266253435;51556.74221628943;55411;55899;55918.72040639852;64057.359426406074;65503;65621.3908235042;65879;65902.67048664822;12462.75074498505;12642.2414655121;12646.30445325516;12649.051321150766;12654.050946179073;9465;9511.524423778783;9514.19129374011;9514.524273786283;9517.666881659246;19083.2366705333;19220.807791921903;19281.903590481958;19288.421347359603;19289;7467.290607392289;7607.771766847003;7690.384769218561;7699.884501732478;7703.57630330326;845.7589586967807;873.2533683700472;875.2341701011615;878.7759121423996;880.3221519430131;25882.96468141291;29809.40381192364;31065.689343106733;31131;31394.529082063786;932.8181004704018;981.8772653418323;986.156835905305;992.9156021738233;1032.2413026425572;15078.54764357071;16041;16098.919505402398;16119.435819746253;16346.509604711877;334034;336541;338596;339061;340408;49538.25692614614;49904.251436228486;49927.500724992286;50034.24948625774;50038;1179.433871741569;1185.1822242652543;1207.8369420128347;1212.678640160358;1221.267239656217;26808.195754127406;27452.862735686194;27548.17355479339;27989.160325190278;28035.71964280331;35938.64061359457;39765.20469590534;40205.597944020185;40324.3951340736;40387.3941890866;204192;205973;253409;254173;255652;25069.373265668502;25186.874065629556;25221.621675675247;25246.621300680137;25341;38638.42042369423;38708.225835483696;38724;39565.60434395619;39811.40282895701;32466.83766581152;32687.18282042968;33196.66803331936;33476.49785253272;33546.83226583949;32836.34327313488;32942.17644558905;33078.5038224422;33297.33405331928;33485.665143348255;33662.663373365955;33942.15144621404;38129.61870381261;39161.2167756649;39168.2166356677;29368.09107408097;30908.69091309058;31084;31166.532502012033;31288.530672040393;23893.761062389152;23920.52158956846;23926.769886065158;24094.39764005914;24269.393265167804 05:11:06 INFO - 2015-11-25 05:11:06,628 DEBUG : BROWSER_OUTPUT: |2;jquery.html;325.3606662907388;331.9435695931691;332.3834287396877;339.2959608811716;339.5246654683444;12434.25394476332;12786.424610892509;14678.339474723636;16151.917587191263;16684.41604543841;11861;13211.603651890458;14132.57602271931;15110.320035598397;15126.092434453913;4918.581920536759;5066.544011039005;5068.797248110071;5104.515071068243;5248.448912864152;3395.3888300105973;3486.6164721880573;5127.9230811537855;5226.05930932432;5255.237990491377;5245.9213111803165;5310.7610157543;5322.042032434179;5333.786648534054;5335.466453354672;5295.8146464873735;5308.389535203443;5522.420145884665;5809.24479817621;5819;5158.509941555584;5158.587313014949;5164.431912489623;5166.896662066775;5168.7415629218385;11565.190436669436;12063.457144428521;12303.4463449145;12304.569340073143;12304.646488886216;1660.5267498762794;1709.4786090242471;1841.917113729872;1854.554906822353;1873.7657792775904;9113.453192808387;9323.393979391318;12225.633231002996;12613.243205407705;13043.934780326037;1774.3967051202653;1794.1926133240095;1825.3702472646914;1866.4214093631017;1869.2149297295168;53649;55763.72118139424;56472.15291770668;57042.1478926052;57290.713546432;9642.951785241028;9812.558434870449;9890.703278901645;9973.553834694074;10043.949780251198;12709.300988445539;12714.046446516548;12728;12739.980801535856;12748.55380061712;6906.309369063053;6934.16789985205;6945.236024037352;7024.402925751267;7029.29707029293;6488.383603557654;6490.188726409199;6490.2536208335705;6516.315786842408;6557.278699343068;4234.0896707207485;4236.872893813191;4240.194363071007;4243.045314804206;4263.4031235627035;1594.4020992127953;1625.7805196298584;1638.1317901512218;1689.3496004038534;1706.351586397161;387.43241151712874;390.8729662859582;427.4635332657557;438.14342959514073;907.1110311894248;10143.695689129338;10201.94899025515;10276.383416995004;10371.636992705218;10462.319949203278;381.8701641441923;383.643211813011;417.52402261422003;450.6552487347182;455.86551967169765;5378.2470454136455;5577.414371491016;5636.4927156556105;5640.464155905182;5692.857678558069;447301;447667;460095;467020;469164;72446;72761.6361918187;73291;73704.63147684227;74048;456.62100456620925;461.58687974262847;462.8935344870631;463.88866671998477;464.4612249790227;9255.305852061258;9322.860157097784;9373.531323433665;9414.62341506332;9439.244860411289;29399.706002939696;29830.403391932476;30266.54600180955;34411.31177376388;34470.138246543036;40350.59649403468;40541.39187912243;40920.38619420651;40977;42020.36969445522;8673.826523469621;8887.466751994902;9056.818863622559;9083.273338133065;9085.182333589744;13599.864001360256;15371.30829112715;16042.598935026717;16479.176041197654;16585.91707041457;13343.466261349437;13507.324633768469;13517.932410337886;14044.78932816029;14188.148711077369;12853.293068880927;13153.07928445038;13417.396217170055;13509.121907076009;13842.584722458343;10803.45982700846;12870.391201099863;12892.548760793703;12963.546275880299;13575.86424135746;8575.95712021436;9025.548722563977;9135.451872887383;9159.267258619162;9169.862452063091;9246.722598322061;9327.720168394959;11377.772444550897;12491.93754031224;12781.936090319861 05:11:06 INFO - 2015-11-25 05:11:06,630 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1355.4171706166358;1550.6898620275945;1603.9198040097992;1609.123027949767;1663.9168041597918;5855.297364316278;6611.933880661192;6903.620300883449;6912.758053468129;6923.134608173978;6841.350071743189;7011.824704382393;7023.438124950005;7024.929750702491;7031.6484175791265;1739.9826001739948;1786.4194136905558;2010.286348346338;2059.4542446251717;2092.5814837032576;2016.84873634478;2021.7068525063858;2023.9291624793136;2024.2409096588779;2025.0988310201967;1967.7638683358018;2018.798120187984;2098.3495116513855;2104.905279262437;2105;2035.8371330293542;2055.660815965364;2072.357569153567;2092.550101728128;2093.2045822587397;2061.721667574888;2073.232903825579;2092.4664210626192;2092.5082605587827;2094.0262777808393;6685;6736.6631668416385;6738.730450781963;6750.459963202932;6750.527463077587;4039.1315867088424;4109.835606575763;4126.174765047002;4127.33962565991;4128.483939507561;2272.0798076778765;2708.4583083383404;2826.0956493921954;2834.8724307406214;2835.773138148943;780.3601047141346;783.3576467296818;830.2818062376001;878.452487785421;912.1744820937063;9231.261499080058;9234.399764015317;9241.49171795551;9242.399244049115;9257.629694812267;3880.0881792778673;3925.823337949799;3974.324364857981;3981;3991.660708839723;7944.84110317802;7949.841003179904;7958.283754462126;7961.601919903982;7968.561729104955;4087.5708050654252;4089.5705950875326;4103.384492326115;4105.7331273467125;4115.9176816463505;3724.4227144792058;3759.191773768653;3759.548854137521;3760.5487341518647;3772.320982223226;2949.454350945082;3040.3463255400197;3270.705636492727;3382.8985130445635;3412.351653185887;1054.599252284127;1054.7099547624312;1057.5029736024057;1081.4862940103387;1083.1118482843992;737.4466033131522;759.3621358059256;759.8936148939152;817.0522194254636;938.0525669074284;6375;6409.262934762469;6415.101885736;6437.774677886251;6439.8068057958335;987.3434166279487;1004.5178314409125;1018.4449475036123;1018.9184865210765;1023.3399457349967;4718;4803.03939212152;4814.013127308894;4819.614430845524;4823.662343635982;7633.885491717629;7753.4572579919995;7841.764747057598;7865.095514015961;7876.09424916142;7902.3678105751405;7943.920560794318;7978.920210797934;7983.281504664492;7998.280154786097;6201.410865967726;6239.126522286883;6244.719832434431;6246.593971391845;6247.219097612799;5929.6145750526075;6035.185249991195;6291.496680265476;6302.842428939313;6303.621782693053;7288.744893928687;7376.151742549676;7416.110066792019;7513.774586762406;7517.548947063194;7456.217097204715;7633.084029916446;7634.389248860189;7640.121386040676;7691.461597688108;5859.707014649336;5893.852653683693;5919.4968427684125;5920.526357891445;5923.378045305181;5381.973090134525;5485.807996720096;6129.754809807736;6208.099825525183;6276.403741644536;5875.823725288248;5949.583529152917;5997.940020599738;6030.7286172121485;6080.48315893154;5889.175515427929;5890;5941.31674857397;5962.25471816023;6017.518598512196;5865.706714664335;5892.6759028253855;5898.852528686817;5906.527477801679;5913.201717768046;5450.427705090909;5732.828015159552;5739.799107031401;5743.339515955551;5751.482366587027;5651.067573850269;5738;5742.08126699726;5757.971210143923;5777.566682498746 05:11:06 INFO - 2015-11-25 05:11:06,631 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.99388012239757;312.6857508204254;314.43401876622085;316.4241081232157;318.51744606920505;5092.541671249587;5132.358455193101;5219.921701174486;5302.628815982887;5308.309919710442;5075.695458272507;5124.92312615311;5215.58275337972;5220.8694782630455;5252.264682944381;4104.199681062194;4110.280700877334;4115.855945041924;4118.79406029698;4118.938215926763;3855.730098893079;3923.8626648067325;3989.840406383741;4062.8984275393054;4072.3484242521204;4044.6562042226446;4064.97967510162;4077.531083925342;4088.2028004539125;4089.631933126018;4051.4327994080854;4056.634902858742;4072.1041370898356;4082.142750022469;4085.1829634073006;3589.174489867345;3594.245208506217;3596.892093237207;3598.442241452553;3604.9098772530633;4914.311996320483;5040.218766091261;5045.495450454925;5053.317802096743;5100.642954993152;4664;4665.5567721066445;4668.463126740435;4675.345451636774;4680.0639872025395;5495.313085864267;5525.364583072957;5528.917066244009;5529.087700529408;5533.22534845122;3623.1304486923214;3677.485152078711;3739.7569158004917;3766.39737641976;3774.245150969817;5704.914426283609;5769.913451298234;5780.653160810407;5781.046127388976;5789.884202315972;3974.066094467798;3979.144483935968;3981.3629819228786;3982.422548730418;3985.940210896839;4036.3340048891605;4041.1109555897656;4045.211183819186;4045.4134150548007;4049.8785036448953;4512.887177820515;4609.354690343354;4618.330342100377;4618.630509559227;4620.584147426748;5509.559235261249;5513.3108361454815;5514.007478653801;5514.310711161105;5527.640703354269;1411.8658727421084;1432.641839540115;1432.7421064208334;1433.0541842383977;1433.2332202271734;958.678842587727;969.0261287406253;974.8099120671401;979.0503211884461;992.151710287708;4844.4186697596515;4859.927101093486;4864.562189402971;4864.8783780405065;4868.099401610713;5729.197912292282;5730.942690573041;5731.197632331477;5734.455226753452;5737.3115226172295;4847.175980083394;4851.975740121276;4860;4860.64258834465;4860.73265970375;2988.5666578346454;3072.416240914219;3094.3501864608684;3095.659477457478;3099.6745341738792;5452.154915988028;5488.1493368527945;5490.258815059996;5492.588055895744;5493.368262649767;5936.821895343147;5944.613600115978;5945.762169513171;5950.761969521257;5953.76184952597;5450.945490545123;5471.50756431923;5483.095289277225;5485.040117979338;5493.23094766733;5641.605087643826;5783.624064435799;5793.710314484343;5794.072948328248;5795.478406943227;5428.6199966002005;5564.165375193753;5567.276254086943;5660.886782264414;5669.829905102853;5319.920201197063;5379.35447746273;5380.946190538045;5384.461553844584;5430.891382172414;3928.0965377962657;3936.0159960009996;3946.4474973504307;3946.4672269244434;3950.9012274693364;5754.8273551791835;5762.567807414377;5769.653820770767;5772.076467765138;5774.9133762994425;5431.755570999394;5583.69289689071;5583.748731307182;5586.692731899622;5588.944110558842;5568.081266590967;5575.275214222125;5578.553715702815;5579.721013949205;5584.357798853184;5449.754761035683;5458.972705136449;5469.753861076181;5470.070088084955;5472.589555783412;5448.700321482356;5611.074172761449;5611.214429979725;5617.213590097472;5624.690642014729;5446.564274857923;5454.3454785426;5471.370792358771;5477.643953143033;5493.670379777226 05:11:06 INFO - 2015-11-25 05:11:06,632 DEBUG : BROWSER_OUTPUT: |5;yui.html;654.8984907339365;673.1652750589268;768.2701433638042;770.1912991359071;794.8012996750813;10829.783404331909;10940.343579385242;11031.779364412707;11034.889651103487;11035.062019728322;11535.538578456852;11630.941845290783;12801;13216.273104979222;13218.471261149543;615.1756646094233;622.9626222426647;768.1051574915231;783.0525064671754;783.0759703549837;760.4904713841712;771.5524995502623;777.6617171530403;778.5134291068082;779.0378882080626;807.725373373053;816.3591580609223;816.3795515408302;817.060380562355;817.0644611919349;636.3159603426312;645.2321737132797;799.2606838674203;808.107041718901;819.0212695828487;583.3845293215655;589.8083122985047;590.1796502861026;590.7548367427512;591.5267785771366;12529.74940501185;12531.373431328397;12548.309842958633;12552.8117078243;12566.560170394083;10976.780464390667;11107.500162492708;11522.711932201762;11592.155848548007;11748;9315.254779617615;9458.101480359355;9517.857232141523;9527.428354298765;9675.903240967571;3334.149791803099;3376.3416133853907;3381.5773028371455;3396.0660818274923;3462.3767721810063;42696.78651606722;43095.138097238196;43103.56896431027;43372.566274337165;43831.12337753259;9268.72193834186;9289.674861379819;9450.52747362643;9487.857682134774;9550.761230969143;15131.394744210329;15235;15277.465288715064;15282.694346113016;15300.311485983157;6155.630662160284;6213.37866213375;6225.439710426083;6297.622142671455;6378.872422551523;3473.0796338970194;3526.3123690880543;3543.6102028776813;3567.090391950036;3618.7285953553587;2727.1409506005944;2771.362586605092;2775.2229375774414;2780.124260857823;2785.5821626756147;480.39230373576754;491.6189952786619;491.6263639633904;494.57713654825324;507.13533425509416;414.4053283538132;478.63384510849227;532.6165161084014;540.699911549094;552.8756029893242;7095.991482829442;7255.982697272047;7384.261573842573;7397;7515.511491753128;382.844947796143;464.665440882564;512.1549443418389;521.4477610460699;539.0647227061046;3504.5093686883856;3523.7885726855957;3529.435290353531;3759.3797023491366;3866.7486613370043;48586;49741.751291243316;49906.251406228934;49931.25103123456;49951;43955.560444395785;43980;44654;45904.77047614741;46097;41782.79108604437;41868.162636747096;42063;42101.578984209766;43530.082292593186;6578.638174900235;6619.66901654925;6641.5207453851735;6736.562123461959;6764.830879228059;32242.193945151557;32311.35377292488;32772.34455310833;33037.66962330346;33101;36839;36962.26075478529;37064;41002.38496422496;41113.79443102765;8804.691835785718;9329.807495238749;9351.766205844908;9392.154706076486;9399.20106790903;10219.59121635156;10300.536475858455;10307.94846025765;10449.58201671955;10530.526126324487;9293.117153870371;9802.607895684092;9904.059114384121;9969.102780749767;10078.294519383866;9813.852792208265;9887.110160085627;9896.20830333586;9909.405435673594;10050.798984020132;8194;9491.525423728648;9756.414615123116;9894.109530142034;9917.206623470249;8233.46482478637;8311.792205194919;8395.95802020986;8558.400911936105;8583.098774628574;8057.5165490070785;8457;8497.87253191215;8566.217509169312;8609.311255099452 05:11:06 INFO - 2015-11-25 05:11:06,632 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:11:06 INFO - 2015-11-25 05:11:06,632 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:11:06 INFO - 2015-11-25 05:11:06,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,959 05:11:06 INFO - 2015-11-25 05:11:06,632 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:11:06 INFO - 2015-11-25 05:11:06,632 DEBUG : BROWSER_OUTPUT: __startTimestamp1448457066620__endTimestamp 05:11:06 INFO - 2015-11-25 05:11:06,633 DEBUG : BROWSER_OUTPUT: 05:11:06 INFO - 2015-11-25 05:11:06,633 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:11:06 INFO - 2015-11-25 05:11:06,633 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:11:06 INFO - 2015-11-25 05:11:06,633 DEBUG : BROWSER_OUTPUT: 05:11:06 INFO - 2015-11-25 05:11:06,633 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4554.39 Median:4654.81 stddev:466.97 (10.0%) stddev-sans-first:442.58 05:11:06 INFO - 2015-11-25 05:11:06,633 DEBUG : BROWSER_OUTPUT: Values: 2602.2 2686.2 2697.6 2711.2 2719.3 4475.4 4512.8 4578.8 4610.3 4621.3 4472.6 4561.0 4573.3 4577.2 4578.0 4262.3 4315.7 4323.1 4338.2 4352.3 4093.7 4374.8 4379.5 4392.2 4411.8 4198.3 4246.8 4254.1 4263.6 4294.6 4258.5 4277.9 4281.2 4298.1 4332.5 4077.7 4180.1 4248.4 4276.4 4309.5 4446.4 4496.7 4590.6 4610.8 4636.9 5005.3 5012.3 5017.3 5022.9 5039.6 4762.1 4881.3 5030.1 5037.8 5058.4 4551.4 4597.8 4659.5 4679.4 4728.1 5099.7 5115.9 5118.5 5118.6 5152.0 4593.2 4706.1 4911.6 4913.9 4914.6 4836.5 4858.8 4916.0 4924.6 4970.5 4894.1 4897.7 4901.6 4932.5 4943.4 4730.5 4852.2 4880.4 4888.9 4931.4 4022.7 4028.2 4122.7 4140.2 4143.2 3598.3 3601.7 3610.2 3633.9 3645.7 4271.9 4273.2 4275.9 4281.2 4317.9 4703.9 4807.3 4833.6 4954.7 5086.9 4226.6 4261.5 4264.1 4266.0 4302.0 4358.7 4373.9 4378.3 4396.7 4412.2 4544.7 4581.0 4653.6 4654.8 4669.6 4951.8 4954.0 4977.6 4978.3 5009.4 4706.4 4719.2 4719.9 4722.4 4769.5 4634.3 4695.6 4733.3 4748.6 4838.5 4895.6 4960.3 4963.2 4966.2 5008.7 4801.9 4820.7 4822.1 4823.1 4872.5 4609.1 4672.2 4730.3 4733.4 4760.4 4697.3 4751.3 4756.5 4773.5 4788.9 4878.4 4882.8 4891.3 4894.0 4899.6 4487.6 4598.2 4601.4 4618.3 4773.0 05:11:06 INFO - 2015-11-25 05:11:06,633 DEBUG : BROWSER_OUTPUT: 05:11:06 INFO - 2015-11-25 05:11:06,633 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42657.63 Median:187175.08 stddev:70304.07 (37.6%) stddev-sans-first:70430.10 05:11:06 INFO - 2015-11-25 05:11:06,633 DEBUG : BROWSER_OUTPUT: Values: 519.0 540.2 551.2 581.1 583.7 27852.0 28476.1 36400.5 36410.0 36490.0 39985.6 40500.6 40503.0 40506.4 40681.6 6942.2 7689.0 7883.2 7888.7 7895.6 6923.1 7007.5 9862.3 10089.6 10098.3 9694.1 9828.3 9848.0 9861.0 9880.0 7040.0 7220.5 9857.8 9978.0 9981.9 10059.6 10374.4 10378.7 10379.8 10384.5 37195.0 37849.4 37904.8 37936.4 37960.8 2880.7 2945.9 2967.0 3078.7 3452.6 28186.2 28371.7 28402.9 28438.7 28810.9 3318.3 3505.9 3508.8 3517.7 3629.4 213450.0 215381.0 215399.0 215516.0 215632.0 50146.7 51556.7 55411.0 55899.0 55918.7 64057.4 65503.0 65621.4 65879.0 65902.7 12462.8 12642.2 12646.3 12649.1 12654.1 9465.0 9511.5 9514.2 9514.5 9517.7 19083.2 19220.8 19281.9 19288.4 19289.0 7467.3 7607.8 7690.4 7699.9 7703.6 845.8 873.3 875.2 878.8 880.3 25883.0 29809.4 31065.7 31131.0 31394.5 932.8 981.9 986.2 992.9 1032.2 15078.5 16041.0 16098.9 16119.4 16346.5 334034.0 336541.0 338596.0 339061.0 340408.0 49538.3 49904.3 49927.5 50034.2 50038.0 1179.4 1185.2 1207.8 1212.7 1221.3 26808.2 27452.9 27548.2 27989.2 28035.7 35938.6 39765.2 40205.6 40324.4 40387.4 204192.0 205973.0 253409.0 254173.0 255652.0 25069.4 25186.9 25221.6 25246.6 25341.0 38638.4 38708.2 38724.0 39565.6 39811.4 32466.8 32687.2 33196.7 33476.5 33546.8 32836.3 32942.2 33078.5 33297.3 33485.7 33662.7 33942.2 38129.6 39161.2 39168.2 29368.1 30908.7 31084.0 31166.5 31288.5 23893.8 23920.5 23926.8 24094.4 24269.4 05:11:06 INFO - 2015-11-25 05:11:06,634 DEBUG : BROWSER_OUTPUT: 05:11:06 INFO - 2015-11-25 05:11:06,634 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24846.29 Median:4238.53 stddev:75028.66 (1770.2%) stddev-sans-first:75216.54 05:11:06 INFO - 2015-11-25 05:11:06,634 DEBUG : BROWSER_OUTPUT: Values: 325.4 331.9 332.4 339.3 339.5 12434.3 12786.4 14678.3 16151.9 16684.4 11861.0 13211.6 14132.6 15110.3 15126.1 4918.6 5066.5 5068.8 5104.5 5248.4 3395.4 3486.6 5127.9 5226.1 5255.2 5245.9 5310.8 5322.0 5333.8 5335.5 5295.8 5308.4 5522.4 5809.2 5819.0 5158.5 5158.6 5164.4 5166.9 5168.7 11565.2 12063.5 12303.4 12304.6 12304.6 1660.5 1709.5 1841.9 1854.6 1873.8 9113.5 9323.4 12225.6 12613.2 13043.9 1774.4 1794.2 1825.4 1866.4 1869.2 53649.0 55763.7 56472.2 57042.1 57290.7 9643.0 9812.6 9890.7 9973.6 10043.9 12709.3 12714.0 12728.0 12740.0 12748.6 6906.3 6934.2 6945.2 7024.4 7029.3 6488.4 6490.2 6490.3 6516.3 6557.3 4234.1 4236.9 4240.2 4243.0 4263.4 1594.4 1625.8 1638.1 1689.3 1706.4 387.4 390.9 427.5 438.1 907.1 10143.7 10201.9 10276.4 10371.6 10462.3 381.9 383.6 417.5 450.7 455.9 5378.2 5577.4 5636.5 5640.5 5692.9 447301.0 447667.0 460095.0 467020.0 469164.0 72446.0 72761.6 73291.0 73704.6 74048.0 456.6 461.6 462.9 463.9 464.5 9255.3 9322.9 9373.5 9414.6 9439.2 29399.7 29830.4 30266.5 34411.3 34470.1 40350.6 40541.4 40920.4 40977.0 42020.4 8673.8 8887.5 9056.8 9083.3 9085.2 13599.9 15371.3 16042.6 16479.2 16585.9 13343.5 13507.3 13517.9 14044.8 14188.1 12853.3 13153.1 13417.4 13509.1 13842.6 10803.5 12870.4 12892.5 12963.5 13575.9 8576.0 9025.5 9135.5 9159.3 9169.9 9246.7 9327.7 11377.8 12491.9 12781.9 05:11:06 INFO - 2015-11-25 05:11:06,634 DEBUG : BROWSER_OUTPUT: 05:11:06 INFO - 2015-11-25 05:11:06,634 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4729.70 Median:5889.59 stddev:2414.56 (41.0%) stddev-sans-first:2408.01 05:11:06 INFO - 2015-11-25 05:11:06,635 DEBUG : BROWSER_OUTPUT: Values: 1355.4 1550.7 1603.9 1609.1 1663.9 5855.3 6611.9 6903.6 6912.8 6923.1 6841.4 7011.8 7023.4 7024.9 7031.6 1740.0 1786.4 2010.3 2059.5 2092.6 2016.8 2021.7 2023.9 2024.2 2025.1 1967.8 2018.8 2098.3 2104.9 2105.0 2035.8 2055.7 2072.4 2092.6 2093.2 2061.7 2073.2 2092.5 2092.5 2094.0 6685.0 6736.7 6738.7 6750.5 6750.5 4039.1 4109.8 4126.2 4127.3 4128.5 2272.1 2708.5 2826.1 2834.9 2835.8 780.4 783.4 830.3 878.5 912.2 9231.3 9234.4 9241.5 9242.4 9257.6 3880.1 3925.8 3974.3 3981.0 3991.7 7944.8 7949.8 7958.3 7961.6 7968.6 4087.6 4089.6 4103.4 4105.7 4115.9 3724.4 3759.2 3759.5 3760.5 3772.3 2949.5 3040.3 3270.7 3382.9 3412.4 1054.6 1054.7 1057.5 1081.5 1083.1 737.4 759.4 759.9 817.1 938.1 6375.0 6409.3 6415.1 6437.8 6439.8 987.3 1004.5 1018.4 1018.9 1023.3 4718.0 4803.0 4814.0 4819.6 4823.7 7633.9 7753.5 7841.8 7865.1 7876.1 7902.4 7943.9 7978.9 7983.3 7998.3 6201.4 6239.1 6244.7 6246.6 6247.2 5929.6 6035.2 6291.5 6302.8 6303.6 7288.7 7376.2 7416.1 7513.8 7517.5 7456.2 7633.1 7634.4 7640.1 7691.5 5859.7 5893.9 5919.5 5920.5 5923.4 5382.0 5485.8 6129.8 6208.1 6276.4 5875.8 5949.6 5997.9 6030.7 6080.5 5889.2 5890.0 5941.3 5962.3 6017.5 5865.7 5892.7 5898.9 5906.5 5913.2 5450.4 5732.8 5739.8 5743.3 5751.5 5651.1 5738.0 5742.1 5758.0 5777.6 05:11:06 INFO - 2015-11-25 05:11:06,635 DEBUG : BROWSER_OUTPUT: 05:11:06 INFO - 2015-11-25 05:11:06,636 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4591.16 Median:5220.40 stddev:1351.48 (25.9%) stddev-sans-first:1316.45 05:11:06 INFO - 2015-11-25 05:11:06,636 DEBUG : BROWSER_OUTPUT: Values: 306.0 312.7 314.4 316.4 318.5 5092.5 5132.4 5219.9 5302.6 5308.3 5075.7 5124.9 5215.6 5220.9 5252.3 4104.2 4110.3 4115.9 4118.8 4118.9 3855.7 3923.9 3989.8 4062.9 4072.3 4044.7 4065.0 4077.5 4088.2 4089.6 4051.4 4056.6 4072.1 4082.1 4085.2 3589.2 3594.2 3596.9 3598.4 3604.9 4914.3 5040.2 5045.5 5053.3 5100.6 4664.0 4665.6 4668.5 4675.3 4680.1 5495.3 5525.4 5528.9 5529.1 5533.2 3623.1 3677.5 3739.8 3766.4 3774.2 5704.9 5769.9 5780.7 5781.0 5789.9 3974.1 3979.1 3981.4 3982.4 3985.9 4036.3 4041.1 4045.2 4045.4 4049.9 4512.9 4609.4 4618.3 4618.6 4620.6 5509.6 5513.3 5514.0 5514.3 5527.6 1411.9 1432.6 1432.7 1433.1 1433.2 958.7 969.0 974.8 979.1 992.2 4844.4 4859.9 4864.6 4864.9 4868.1 5729.2 5730.9 5731.2 5734.5 5737.3 4847.2 4852.0 4860.0 4860.6 4860.7 2988.6 3072.4 3094.4 3095.7 3099.7 5452.2 5488.1 5490.3 5492.6 5493.4 5936.8 5944.6 5945.8 5950.8 5953.8 5450.9 5471.5 5483.1 5485.0 5493.2 5641.6 5783.6 5793.7 5794.1 5795.5 5428.6 5564.2 5567.3 5660.9 5669.8 5319.9 5379.4 5380.9 5384.5 5430.9 3928.1 3936.0 3946.4 3946.5 3950.9 5754.8 5762.6 5769.7 5772.1 5774.9 5431.8 5583.7 5583.7 5586.7 5588.9 5568.1 5575.3 5578.6 5579.7 5584.4 5449.8 5459.0 5469.8 5470.1 5472.6 5448.7 5611.1 5611.2 5617.2 5624.7 5446.6 5454.3 5471.4 5477.6 5493.7 05:11:06 INFO - 2015-11-25 05:11:06,636 DEBUG : BROWSER_OUTPUT: 05:11:06 INFO - 2015-11-25 05:11:06,636 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12165.16 Median:509.65 stddev:14134.57 (2773.4%) stddev-sans-first:14147.79 05:11:06 INFO - 2015-11-25 05:11:06,636 DEBUG : BROWSER_OUTPUT: Values: 654.9 673.2 768.3 770.2 794.8 10829.8 10940.3 11031.8 11034.9 11035.1 11535.5 11630.9 12801.0 13216.3 13218.5 615.2 623.0 768.1 783.1 783.1 760.5 771.6 777.7 778.5 779.0 807.7 816.4 816.4 817.1 817.1 636.3 645.2 799.3 808.1 819.0 583.4 589.8 590.2 590.8 591.5 12529.7 12531.4 12548.3 12552.8 12566.6 10976.8 11107.5 11522.7 11592.2 11748.0 9315.3 9458.1 9517.9 9527.4 9675.9 3334.1 3376.3 3381.6 3396.1 3462.4 42696.8 43095.1 43103.6 43372.6 43831.1 9268.7 9289.7 9450.5 9487.9 9550.8 15131.4 15235.0 15277.5 15282.7 15300.3 6155.6 6213.4 6225.4 6297.6 6378.9 3473.1 3526.3 3543.6 3567.1 3618.7 2727.1 2771.4 2775.2 2780.1 2785.6 480.4 491.6 491.6 494.6 507.1 414.4 478.6 532.6 540.7 552.9 7096.0 7256.0 7384.3 7397.0 7515.5 382.8 464.7 512.2 521.4 539.1 3504.5 3523.8 3529.4 3759.4 3866.7 48586.0 49741.8 49906.3 49931.3 49951.0 43955.6 43980.0 44654.0 45904.8 46097.0 41782.8 41868.2 42063.0 42101.6 43530.1 6578.6 6619.7 6641.5 6736.6 6764.8 32242.2 32311.4 32772.3 33037.7 33101.0 36839.0 36962.3 37064.0 41002.4 41113.8 8804.7 9329.8 9351.8 9392.2 9399.2 10219.6 10300.5 10307.9 10449.6 10530.5 9293.1 9802.6 9904.1 9969.1 10078.3 9813.9 9887.1 9896.2 9909.4 10050.8 8194.0 9491.5 9756.4 9894.1 9917.2 8233.5 8311.8 8396.0 8558.4 8583.1 8057.5 8457.0 8497.9 8566.2 8609.3 05:11:06 INFO - 2015-11-25 05:11:06,636 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:11:06 INFO - 2015-11-25 05:11:06,636 DEBUG : BROWSER_OUTPUT: 05:11:07 INFO - 2015-11-25 05:11:07,301 INFO : Browser exited with error code: 0 05:11:07 INFO - 2015-11-25 05:11:07,320 INFO : Completed test dromaeo_css (00:18:36) 05:11:07 INFO - 2015-11-25 05:11:07,320 INFO : Starting test kraken 05:11:07 INFO - 2015-11-25 05:11:07,320 DEBUG : operating with platform_type : linux_ 05:11:07 INFO - 2015-11-25 05:11:07,320 INFO : Initialising browser for kraken test... 05:11:07 INFO - 2015-11-25 05:11:07,326 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHZWexz/profile http://localhost:48880/getInfo.html 05:11:11 INFO - 2015-11-25 05:11:11,266 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:11:11 INFO - 2015-11-25 05:11:11,266 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:11:11 INFO - 2015-11-25 05:11:11,266 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:11:11 INFO - 2015-11-25 05:11:11,267 DEBUG : BROWSER_OUTPUT: __metrics 05:11:11 INFO - 2015-11-25 05:11:11,389 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:12 INFO - 2015-11-25 05:11:12,545 INFO : Browser initialized. 05:11:12 INFO - 2015-11-25 05:11:12,546 INFO : Running cycle 1/1 for kraken test... 05:11:12 INFO - 2015-11-25 05:11:12,546 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHZWexz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:11:24 INFO - 2015-11-25 05:11:24,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 141389824 05:11:24 INFO - 2015-11-25 05:11:24,419 DEBUG : BROWSER_OUTPUT: 05:11:27 INFO - 2015-11-25 05:11:27,022 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48880/tests/kraken/driver.html?testName=audio-beat-detection) 05:11:27 INFO - 2015-11-25 05:11:27,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 179032064 05:11:27 INFO - 2015-11-25 05:11:27,608 DEBUG : BROWSER_OUTPUT: 05:11:30 INFO - 2015-11-25 05:11:30,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48880/tests/kraken/driver.html?testName=audio-dft) 05:11:30 INFO - 2015-11-25 05:11:30,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 165289984 05:11:30 INFO - 2015-11-25 05:11:30,869 DEBUG : BROWSER_OUTPUT: 05:11:33 INFO - 2015-11-25 05:11:33,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48880/tests/kraken/driver.html?testName=audio-fft) 05:11:34 INFO - 2015-11-25 05:11:34,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 151576576 05:11:34 INFO - 2015-11-25 05:11:34,408 DEBUG : BROWSER_OUTPUT: 05:11:36 INFO - 2015-11-25 05:11:36,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48880/tests/kraken/driver.html?testName=audio-oscillator) 05:11:37 INFO - 2015-11-25 05:11:37,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 151175168 05:11:37 INFO - 2015-11-25 05:11:37,025 DEBUG : BROWSER_OUTPUT: 05:11:39 INFO - 2015-11-25 05:11:39,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48880/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:11:39 INFO - 2015-11-25 05:11:39,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 155414528 05:11:39 INFO - 2015-11-25 05:11:39,888 DEBUG : BROWSER_OUTPUT: 05:11:42 INFO - 2015-11-25 05:11:42,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48880/tests/kraken/driver.html?testName=imaging-darkroom) 05:11:43 INFO - 2015-11-25 05:11:43,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 155226112 05:11:43 INFO - 2015-11-25 05:11:43,464 DEBUG : BROWSER_OUTPUT: 05:11:46 INFO - 2015-11-25 05:11:46,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48880/tests/kraken/driver.html?testName=imaging-desaturate) 05:11:47 INFO - 2015-11-25 05:11:47,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 154546176 05:11:47 INFO - 2015-11-25 05:11:47,466 DEBUG : BROWSER_OUTPUT: 05:11:50 INFO - 2015-11-25 05:11:50,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48880/tests/kraken/driver.html?testName=json-parse-financial) 05:11:50 INFO - 2015-11-25 05:11:50,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 155705344 05:11:50 INFO - 2015-11-25 05:11:50,896 DEBUG : BROWSER_OUTPUT: 05:11:52 INFO - 2015-11-25 05:11:52,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48880/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:11:53 INFO - 2015-11-25 05:11:53,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 165306368 05:11:53 INFO - 2015-11-25 05:11:53,223 DEBUG : BROWSER_OUTPUT: 05:11:55 INFO - 2015-11-25 05:11:55,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48880/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:11:55 INFO - 2015-11-25 05:11:55,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 165777408 05:11:55 INFO - 2015-11-25 05:11:55,675 DEBUG : BROWSER_OUTPUT: 05:11:57 INFO - 2015-11-25 05:11:57,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48880/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:11:58 INFO - 2015-11-25 05:11:58,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 174149632 05:11:58 INFO - 2015-11-25 05:11:58,388 DEBUG : BROWSER_OUTPUT: 05:12:00 INFO - 2015-11-25 05:12:00,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:12:01 INFO - 2015-11-25 05:12:01,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 181219328 05:12:01 INFO - 2015-11-25 05:12:01,494 DEBUG : BROWSER_OUTPUT: 05:12:04 INFO - 2015-11-25 05:12:04,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:12:04 INFO - 2015-11-25 05:12:04,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 177836032 05:12:04 INFO - 2015-11-25 05:12:04,702 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48880/tests/kraken/driver.html?testName=ai-astar) 05:12:06 INFO - 2015-11-25 05:12:06,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 235909120 05:12:06 INFO - 2015-11-25 05:12:06,706 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,706 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:12:06 INFO - 2015-11-25 05:12:06,707 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:12:06 INFO - 2015-11-25 05:12:06,707 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:12:06 INFO - 2015-11-25 05:12:06,707 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:12:06 INFO - 2015-11-25 05:12:06,707 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;114;106;113;112;113;102;112;112;106 05:12:06 INFO - 2015-11-25 05:12:06,707 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;131;158;163;130;156;163;132;163;130 05:12:06 INFO - 2015-11-25 05:12:06,707 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;160;161;159;162;163;162;159 05:12:06 INFO - 2015-11-25 05:12:06,707 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;84;93;71;73;72;94;98;71 05:12:06 INFO - 2015-11-25 05:12:06,707 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;105;138;93;94;95;136;94;94;134 05:12:06 INFO - 2015-11-25 05:12:06,707 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;110;110;109;109;109 05:12:06 INFO - 2015-11-25 05:12:06,707 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;147;146;146;147;147;146;146 05:12:06 INFO - 2015-11-25 05:12:06,708 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;97;95;96;95;96 05:12:06 INFO - 2015-11-25 05:12:06,708 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;70;72;70;71;71;76;71;68 05:12:06 INFO - 2015-11-25 05:12:06,708 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;67;69;68;68;67;68;69 05:12:06 INFO - 2015-11-25 05:12:06,708 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;83;82;93;84;85;85;83;83 05:12:06 INFO - 2015-11-25 05:12:06,708 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;128;125;118;126;126;122;135;125;121 05:12:06 INFO - 2015-11-25 05:12:06,708 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;140;152;147;148;148;160;146;164;140 05:12:06 INFO - 2015-11-25 05:12:06,708 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;69;69;69;69;67;67;69;68 05:12:06 INFO - 2015-11-25 05:12:06,708 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:12:06 INFO - 2015-11-25 05:12:06,708 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:12:06 INFO - 2015-11-25 05:12:06,709 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 05:12:06 INFO - 2015-11-25 05:12:06,709 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:12:06 INFO - 2015-11-25 05:12:06,709 DEBUG : BROWSER_OUTPUT: __startTimestamp1448457126705__endTimestamp 05:12:06 INFO - 2015-11-25 05:12:06,709 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,713 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:12:06 INFO - 2015-11-25 05:12:06,713 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:12:06 INFO - 2015-11-25 05:12:06,713 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,713 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:3.97 (3.5%) stddev-sans-first:4.21 05:12:06 INFO - 2015-11-25 05:12:06,713 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 106.0 113.0 112.0 113.0 102.0 112.0 112.0 106.0 05:12:06 INFO - 2015-11-25 05:12:06,713 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,715 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.90 Median:157.00 stddev:15.12 (9.6%) stddev-sans-first:15.92 05:12:06 INFO - 2015-11-25 05:12:06,715 DEBUG : BROWSER_OUTPUT: Values: 153.0 131.0 158.0 163.0 130.0 156.0 163.0 132.0 163.0 130.0 05:12:06 INFO - 2015-11-25 05:12:06,715 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,715 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 05:12:06 INFO - 2015-11-25 05:12:06,715 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 160.0 161.0 159.0 162.0 163.0 162.0 159.0 05:12:06 INFO - 2015-11-25 05:12:06,715 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,715 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:78.50 stddev:11.26 (14.3%) stddev-sans-first:11.49 05:12:06 INFO - 2015-11-25 05:12:06,715 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 84.0 93.0 71.0 73.0 72.0 94.0 98.0 71.0 05:12:06 INFO - 2015-11-25 05:12:06,715 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,715 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.80 Median:94.00 stddev:19.78 (21.0%) stddev-sans-first:20.43 05:12:06 INFO - 2015-11-25 05:12:06,716 DEBUG : BROWSER_OUTPUT: Values: 95.0 105.0 138.0 93.0 94.0 95.0 136.0 94.0 94.0 134.0 05:12:06 INFO - 2015-11-25 05:12:06,716 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,716 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:12:06 INFO - 2015-11-25 05:12:06,716 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 05:12:06 INFO - 2015-11-25 05:12:06,716 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,716 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:12:06 INFO - 2015-11-25 05:12:06,716 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 05:12:06 INFO - 2015-11-25 05:12:06,716 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,716 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:12:06 INFO - 2015-11-25 05:12:06,717 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 97.0 95.0 96.0 95.0 96.0 05:12:06 INFO - 2015-11-25 05:12:06,717 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,717 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.00 Median:71.00 stddev:2.05 (2.9%) stddev-sans-first:2.18 05:12:06 INFO - 2015-11-25 05:12:06,717 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 72.0 70.0 71.0 71.0 76.0 71.0 68.0 05:12:06 INFO - 2015-11-25 05:12:06,717 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,717 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:12:06 INFO - 2015-11-25 05:12:06,717 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 67.0 69.0 68.0 68.0 67.0 68.0 69.0 05:12:06 INFO - 2015-11-25 05:12:06,717 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,717 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.50 stddev:3.29 (3.9%) stddev-sans-first:3.40 05:12:06 INFO - 2015-11-25 05:12:06,717 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 83.0 82.0 93.0 84.0 85.0 85.0 83.0 83.0 05:12:06 INFO - 2015-11-25 05:12:06,718 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,718 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:126.00 stddev:4.57 (3.6%) stddev-sans-first:4.81 05:12:06 INFO - 2015-11-25 05:12:06,718 DEBUG : BROWSER_OUTPUT: Values: 127.0 128.0 125.0 118.0 126.0 126.0 122.0 135.0 125.0 121.0 05:12:06 INFO - 2015-11-25 05:12:06,718 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,718 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:149.50 stddev:7.69 (5.1%) stddev-sans-first:8.14 05:12:06 INFO - 2015-11-25 05:12:06,718 DEBUG : BROWSER_OUTPUT: Values: 151.0 140.0 152.0 147.0 148.0 148.0 160.0 146.0 164.0 140.0 05:12:06 INFO - 2015-11-25 05:12:06,718 DEBUG : BROWSER_OUTPUT: 05:12:06 INFO - 2015-11-25 05:12:06,718 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 05:12:06 INFO - 2015-11-25 05:12:06,718 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 69.0 67.0 67.0 69.0 68.0 05:12:06 INFO - 2015-11-25 05:12:06,719 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:12:06 INFO - 2015-11-25 05:12:06,719 DEBUG : BROWSER_OUTPUT: 05:12:07 INFO - 2015-11-25 05:12:07,613 INFO : Browser exited with error code: 0 05:12:07 INFO - 2015-11-25 05:12:07,664 INFO : Completed test kraken (00:01:00) 05:12:07 INFO - 2015-11-25 05:12:07,664 INFO : Starting test v8_7 05:12:07 INFO - 2015-11-25 05:12:07,664 DEBUG : operating with platform_type : linux_ 05:12:07 INFO - 2015-11-25 05:12:07,664 INFO : Initialising browser for v8_7 test... 05:12:07 INFO - 2015-11-25 05:12:07,670 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm19xlv/profile http://localhost:48880/getInfo.html 05:12:11 INFO - 2015-11-25 05:12:11,709 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:12:11 INFO - 2015-11-25 05:12:11,709 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:12:11 INFO - 2015-11-25 05:12:11,709 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:12:11 INFO - 2015-11-25 05:12:11,709 DEBUG : BROWSER_OUTPUT: __metrics 05:12:11 INFO - 2015-11-25 05:12:11,878 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:12 INFO - 2015-11-25 05:12:12,989 INFO : Browser initialized. 05:12:12 INFO - 2015-11-25 05:12:12,990 INFO : Running cycle 1/1 for v8_7 test... 05:12:12 INFO - 2015-11-25 05:12:12,990 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm19xlv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:12:24 INFO - 2015-11-25 05:12:24,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 139218944 05:12:24 INFO - 2015-11-25 05:12:24,880 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48880/tests/v8_7/run.html (next: http://localhost:48880/tests/v8_7/run.html) 05:12:46 INFO - 2015-11-25 05:12:46,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 442654720 05:12:46 INFO - 2015-11-25 05:12:46,586 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,586 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:12:46 INFO - 2015-11-25 05:12:46,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:12:46 INFO - 2015-11-25 05:12:46,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:12:46 INFO - 2015-11-25 05:12:46,587 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:12:46 INFO - 2015-11-25 05:12:46,587 DEBUG : BROWSER_OUTPUT: |0;Richards;164.66326362588507 05:12:46 INFO - 2015-11-25 05:12:46,587 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.91118867558657 05:12:46 INFO - 2015-11-25 05:12:46,587 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.1641168289291 05:12:46 INFO - 2015-11-25 05:12:46,587 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 05:12:46 INFO - 2015-11-25 05:12:46,587 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1970.4724409448818 05:12:46 INFO - 2015-11-25 05:12:46,588 DEBUG : BROWSER_OUTPUT: |5;Earley;805.8017727639001 05:12:46 INFO - 2015-11-25 05:12:46,588 DEBUG : BROWSER_OUTPUT: |6;Boyer;12481.481481481482 05:12:46 INFO - 2015-11-25 05:12:46,588 DEBUG : BROWSER_OUTPUT: |7;RegExp;27054.054054054053 05:12:46 INFO - 2015-11-25 05:12:46,588 DEBUG : BROWSER_OUTPUT: |8;Splay;609.3845216331505 05:12:46 INFO - 2015-11-25 05:12:46,588 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4887.804878048781 05:12:46 INFO - 2015-11-25 05:12:46,589 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:12:46 INFO - 2015-11-25 05:12:46,589 DEBUG : BROWSER_OUTPUT: __startTimestamp1448457166584__endTimestamp 05:12:46 INFO - 2015-11-25 05:12:46,589 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,589 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:12:46 INFO - 2015-11-25 05:12:46,589 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:12:46 INFO - 2015-11-25 05:12:46,589 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,589 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.66 Median:164.66 stddev:0.00 (0.0%) 05:12:46 INFO - 2015-11-25 05:12:46,589 DEBUG : BROWSER_OUTPUT: Values: 164.7 05:12:46 INFO - 2015-11-25 05:12:46,589 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,589 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.91 Median:193.91 stddev:0.00 (0.0%) 05:12:46 INFO - 2015-11-25 05:12:46,590 DEBUG : BROWSER_OUTPUT: Values: 193.9 05:12:46 INFO - 2015-11-25 05:12:46,590 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,590 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 05:12:46 INFO - 2015-11-25 05:12:46,590 DEBUG : BROWSER_OUTPUT: Values: 278.2 05:12:46 INFO - 2015-11-25 05:12:46,590 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,590 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 05:12:46 INFO - 2015-11-25 05:12:46,590 DEBUG : BROWSER_OUTPUT: Values: 5181.3 05:12:46 INFO - 2015-11-25 05:12:46,590 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,590 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 05:12:46 INFO - 2015-11-25 05:12:46,590 DEBUG : BROWSER_OUTPUT: Values: 1970.5 05:12:46 INFO - 2015-11-25 05:12:46,590 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,591 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:805.80 Median:805.80 stddev:0.00 (0.0%) 05:12:46 INFO - 2015-11-25 05:12:46,591 DEBUG : BROWSER_OUTPUT: Values: 805.8 05:12:46 INFO - 2015-11-25 05:12:46,591 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,591 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12481.48 Median:12481.48 stddev:0.00 (0.0%) 05:12:46 INFO - 2015-11-25 05:12:46,591 DEBUG : BROWSER_OUTPUT: Values: 12481.5 05:12:46 INFO - 2015-11-25 05:12:46,591 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,591 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27054.05 Median:27054.05 stddev:0.00 (0.0%) 05:12:46 INFO - 2015-11-25 05:12:46,591 DEBUG : BROWSER_OUTPUT: Values: 27054.1 05:12:46 INFO - 2015-11-25 05:12:46,591 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,591 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:609.38 Median:609.38 stddev:0.00 (0.0%) 05:12:46 INFO - 2015-11-25 05:12:46,592 DEBUG : BROWSER_OUTPUT: Values: 609.4 05:12:46 INFO - 2015-11-25 05:12:46,592 DEBUG : BROWSER_OUTPUT: 05:12:46 INFO - 2015-11-25 05:12:46,592 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4887.80 Median:4887.80 stddev:0.00 (0.0%) 05:12:46 INFO - 2015-11-25 05:12:46,592 DEBUG : BROWSER_OUTPUT: Values: 4887.8 05:12:46 INFO - 2015-11-25 05:12:46,592 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:12:46 INFO - 2015-11-25 05:12:46,592 DEBUG : BROWSER_OUTPUT: 05:12:47 INFO - 2015-11-25 05:12:47,437 INFO : Browser exited with error code: 0 05:12:47 INFO - 2015-11-25 05:12:47,456 INFO : Completed test v8_7 (00:00:39) 05:12:47 INFO - 2015-11-25 05:12:47,550 INFO : Completed test suite (00:20:16) 05:12:47 INFO - 2015-11-25 05:12:47,550 DEBUG : Working with test: dromaeo_css 05:12:47 INFO - 2015-11-25 05:12:47,550 DEBUG : Generating results file: dromaeo_css 05:12:47 INFO - 2015-11-25 05:12:47,551 DEBUG : Working with test: kraken 05:12:47 INFO - 2015-11-25 05:12:47,551 DEBUG : Generating results file: kraken 05:12:47 INFO - 2015-11-25 05:12:47,551 INFO : javascript benchmark 05:12:47 INFO - 2015-11-25 05:12:47,552 DEBUG : Working with test: v8_7 05:12:47 INFO - 2015-11-25 05:12:47,552 DEBUG : Generating results file: v8_7 05:12:47 INFO - 2015-11-25 05:12:47,552 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:12:47 INFO - 2015-11-25 05:12:47,608 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 05:12:47 INFO - 2015-11-25 05:12:47,608 DEBUG : process_Request line: dromaeo_css 6111.30 graph.html#tests=[[72,94,35]] 05:12:47 INFO - 2015-11-25 05:12:47,609 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:12:47 INFO - 2015-11-25 05:12:47,639 DEBUG : process_Request line: kraken 1524.00 graph.html#tests=[[232,94,35]] 05:12:47 INFO - 2015-11-25 05:12:47,639 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:12:47 INFO - 2015-11-25 05:12:47,669 DEBUG : process_Request line: v8_7 19625.54 graph.html#tests=[[230,94,35]] 05:12:47 INFO - 2015-11-25 05:12:47,674 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2602.2193341997404, 2686.2112148320366, 2697.595360695894, 2711.2408525612823, 2719.2793909613943, 4475.373447717322, 4512.842050528228, 4578.793954272058, 4610.331501932222, 4621.283701026342, 4472.64218862491, 4561.0193808331205, 4573.26827707566, 4577.153226653063, 4577.977110114453, 4262.3393374027, 4315.654747620199, 4323.135372925428, 4338.175746608134, 4352.325389564622, 4093.6725061995116, 4374.846880359188, 4379.4963579188325, 4392.231359512089, 4411.845585404511, 4198.307279298912, 4246.787660616972, 4254.149170165979, 4263.5736426357425, 4294.613484786384, 4258.53156152823, 4277.871663850089, 4281.229378711831, 4298.054428025829, 4332.501762297345, 4077.7145599808027, 4180.143070670505, 4248.362745588156, 4276.401303817468, 4309.504406993205, 4446.355278484634, 4496.662750293741, 4590.632749380042, 4610.838620648261, 4636.86089417318, 5005.3242812220615, 5012.298278241049, 5017.34774479319, 5022.874428139289, 5039.571636410909, 4762.071396077767, 4881.267809828519, 5030.094582975063, 5037.823676171316, 5058.4435712071645, 4551.431071116111, 4597.793099310506, 4659.534046595313, 4679.415073115861, 4728.101660684459, 5099.668521546162, 5115.923261151086, 5118.488151184926, 5118.59051275897, 5152.0, 4593.219152744042, 4706.082313948816, 4911.631627627942, 4913.852584422401, 4914.582260507826, 4836.516348365135, 4858.78135483904, 4915.95084049155, 4924.556789888928, 4970.478099799541, 4894.094592500399, 4897.706137631753, 4901.58336541398, 4932.482089380635, 4943.3573635427165, 4730.455997560324, 4852.223644216909, 4880.414350277918, 4888.902221955541, 4931.408231012301, 4022.678185745192, 4028.194361127786, 4122.670186385082, 4140.171965606891, 4143.19207754491, 3598.3163198992106, 3601.729870259741, 3610.187707765732, 3633.94549081764, 3645.6901163400876, 4271.9359209611885, 4273.230818452646, 4275.850345237902, 4281.186574550826, 4317.935230971538, 4703.905921881612, 4807.302941073524, 4833.637477189225, 4954.702717836869, 5086.872828179251, 4226.598473145046, 4261.4673165854265, 4264.125854199943, 4266.0188156724125, 4302.010537576312, 4358.738475691469, 4373.868783936487, 4378.255696531597, 4396.692231543825, 4412.205802955499, 4544.6818722689095, 4581.0, 4653.557911998287, 4654.813807447799, 4669.626429885533, 4951.801927922987, 4953.975230123826, 4977.601293038901, 4978.303037574815, 5009.398872135367, 4706.388169537938, 4719.1977363847545, 4719.929201062056, 4722.36248106515, 4769.499202583679, 4634.281686338623, 4695.600873925618, 4733.290006499053, 4748.572628463455, 4838.491958344323, 4895.559399654048, 4960.305557222064, 4963.230699241623, 4966.155753521838, 5008.724520151281, 4801.879953001063, 4820.734859582757, 4822.059698358787, 4823.083614113307, 4872.4883887192755, 4609.147307747943, 4672.229082201398, 4730.266808644528, 4733.36099626546, 4760.428748550196, 4697.295405689174, 4751.334813126096, 4756.453007904135, 4773.522647735337, 4788.928166077581, 4878.390201224847, 4882.829100981448, 4891.315215869852, 4893.951060489349, 4899.608031357411, 4487.64098872096, 4598.241290187216, 4601.355810186509, 4618.261078227468, 4773.04539092176], "unit": "ms", "name": "dojo.html", "value": 4526.153730946651}, {"lowerIsBetter": false, "replicates": [519.0035132545512, 540.1870185371016, 551.2282804074296, 581.0818906128318, 583.6702263221277, 27852.0, 28476.145715628514, 36400.45399319012, 36410.0, 36489.99999999996, 39985.60014399855, 40500.59499405005, 40503.0, 40506.39240411396, 40681.59318406815, 6942.236354001056, 7688.96155519223, 7883.172266911978, 7888.6844526219165, 7895.565743884084, 6923.134608173978, 7007.509474336798, 9862.260330475207, 10089.64686235982, 10098.29311948164, 9694.079062489052, 9828.262880283972, 9847.950760246189, 9861.0, 9880.0, 7039.964800176018, 7220.530665506725, 9857.802843943116, 9978.0, 9981.850272245922, 10059.597616095347, 10374.377537347707, 10378.688639340831, 10379.84430233547, 10384.532696028697, 37195.0, 37849.43225851614, 37904.81047594772, 37936.43095353572, 37960.81019594912, 2880.74073333401, 2945.882164713409, 2966.9554956675665, 3078.707522785332, 3452.5511683480986, 28186.15441536757, 28371.716282837115, 28402.857985710147, 28438.715612844022, 28810.85594572035, 3318.2533929865585, 3505.929881402383, 3508.7543871928974, 3517.66582174693, 3629.4374371972385, 213450.0, 215380.99999999843, 215399.0, 215516.0, 215632.0, 50146.749266253435, 51556.74221628943, 55411.0, 55899.0, 55918.72040639852, 64057.359426406074, 65503.0, 65621.3908235042, 65879.0, 65902.67048664822, 12462.75074498505, 12642.2414655121, 12646.30445325516, 12649.051321150766, 12654.050946179073, 9465.0, 9511.524423778783, 9514.19129374011, 9514.524273786283, 9517.666881659246, 19083.2366705333, 19220.807791921903, 19281.903590481958, 19288.421347359603, 19289.0, 7467.290607392289, 7607.771766847003, 7690.384769218561, 7699.884501732478, 7703.57630330326, 845.7589586967807, 873.2533683700472, 875.2341701011615, 878.7759121423996, 880.3221519430131, 25882.96468141291, 29809.40381192364, 31065.689343106733, 31131.0, 31394.529082063786, 932.8181004704018, 981.8772653418323, 986.156835905305, 992.9156021738233, 1032.2413026425572, 15078.54764357071, 16041.0, 16098.919505402398, 16119.435819746253, 16346.509604711877, 334034.0, 336541.0, 338596.0, 339061.0, 340408.0, 49538.25692614614, 49904.251436228486, 49927.500724992286, 50034.24948625774, 50038.0, 1179.433871741569, 1185.1822242652543, 1207.8369420128347, 1212.678640160358, 1221.267239656217, 26808.195754127406, 27452.862735686194, 27548.17355479339, 27989.160325190278, 28035.71964280331, 35938.64061359457, 39765.20469590534, 40205.597944020185, 40324.3951340736, 40387.3941890866, 204192.0, 205973.0, 253409.0, 254173.0, 255652.0, 25069.373265668502, 25186.874065629556, 25221.621675675247, 25246.621300680137, 25341.0, 38638.42042369423, 38708.225835483696, 38724.0, 39565.60434395619, 39811.40282895701, 32466.83766581152, 32687.18282042968, 33196.66803331936, 33476.49785253272, 33546.83226583949, 32836.34327313488, 32942.17644558905, 33078.5038224422, 33297.33405331928, 33485.665143348255, 33662.663373365955, 33942.15144621404, 38129.61870381261, 39161.2167756649, 39168.2166356677, 29368.09107408097, 30908.69091309058, 31084.0, 31166.532502012033, 31288.530672040393, 23893.761062389152, 23920.52158956846, 23926.769886065158, 24094.39764005914, 24269.393265167804], "unit": "ms", "name": "ext.html", "value": 17365.460185813485}, {"lowerIsBetter": false, "replicates": [325.3606662907388, 331.9435695931691, 332.3834287396877, 339.2959608811716, 339.5246654683444, 12434.25394476332, 12786.424610892509, 14678.339474723636, 16151.917587191263, 16684.41604543841, 11861.0, 13211.603651890458, 14132.57602271931, 15110.320035598397, 15126.092434453913, 4918.581920536759, 5066.544011039005, 5068.797248110071, 5104.515071068243, 5248.448912864152, 3395.3888300105973, 3486.6164721880573, 5127.9230811537855, 5226.05930932432, 5255.237990491377, 5245.9213111803165, 5310.7610157543, 5322.042032434179, 5333.786648534054, 5335.466453354672, 5295.8146464873735, 5308.389535203443, 5522.420145884665, 5809.24479817621, 5819.0, 5158.509941555584, 5158.587313014949, 5164.431912489623, 5166.896662066775, 5168.7415629218385, 11565.190436669436, 12063.457144428521, 12303.4463449145, 12304.569340073143, 12304.646488886216, 1660.5267498762794, 1709.4786090242471, 1841.917113729872, 1854.554906822353, 1873.7657792775904, 9113.453192808387, 9323.393979391318, 12225.633231002996, 12613.243205407705, 13043.934780326037, 1774.3967051202653, 1794.1926133240095, 1825.3702472646914, 1866.4214093631017, 1869.2149297295168, 53649.0, 55763.72118139424, 56472.15291770668, 57042.1478926052, 57290.713546432, 9642.951785241028, 9812.558434870449, 9890.703278901645, 9973.553834694074, 10043.949780251198, 12709.300988445539, 12714.046446516548, 12728.0, 12739.980801535856, 12748.55380061712, 6906.309369063053, 6934.16789985205, 6945.236024037352, 7024.402925751267, 7029.29707029293, 6488.383603557654, 6490.188726409199, 6490.2536208335705, 6516.315786842408, 6557.278699343068, 4234.0896707207485, 4236.872893813191, 4240.194363071007, 4243.045314804206, 4263.4031235627035, 1594.4020992127953, 1625.7805196298584, 1638.1317901512218, 1689.3496004038534, 1706.351586397161, 387.43241151712874, 390.8729662859582, 427.4635332657557, 438.14342959514073, 907.1110311894248, 10143.695689129338, 10201.94899025515, 10276.383416995004, 10371.636992705218, 10462.319949203278, 381.8701641441923, 383.643211813011, 417.52402261422003, 450.6552487347182, 455.86551967169765, 5378.2470454136455, 5577.414371491016, 5636.4927156556105, 5640.464155905182, 5692.857678558069, 447301.0, 447667.0, 460095.0, 467020.0, 469164.0, 72446.0, 72761.6361918187, 73291.0, 73704.63147684227, 74048.0, 456.62100456620925, 461.58687974262847, 462.8935344870631, 463.88866671998477, 464.4612249790227, 9255.305852061258, 9322.860157097784, 9373.531323433665, 9414.62341506332, 9439.244860411289, 29399.706002939696, 29830.403391932476, 30266.54600180955, 34411.31177376388, 34470.138246543036, 40350.59649403468, 40541.39187912243, 40920.38619420651, 40977.0, 42020.36969445522, 8673.826523469621, 8887.466751994902, 9056.818863622559, 9083.273338133065, 9085.182333589744, 13599.864001360256, 15371.30829112715, 16042.598935026717, 16479.176041197654, 16585.91707041457, 13343.466261349437, 13507.324633768469, 13517.932410337886, 14044.78932816029, 14188.148711077369, 12853.293068880927, 13153.07928445038, 13417.396217170055, 13509.121907076009, 13842.584722458343, 10803.45982700846, 12870.391201099863, 12892.548760793703, 12963.546275880299, 13575.86424135746, 8575.95712021436, 9025.548722563977, 9135.451872887383, 9159.267258619162, 9169.862452063091, 9246.722598322061, 9327.720168394959, 11377.772444550897, 12491.93754031224, 12781.936090319861], "unit": "ms", "name": "jquery.html", "value": 7377.032105134548}, {"lowerIsBetter": false, "replicates": [1355.4171706166358, 1550.6898620275945, 1603.9198040097992, 1609.123027949767, 1663.9168041597918, 5855.297364316278, 6611.933880661192, 6903.620300883449, 6912.758053468129, 6923.134608173978, 6841.350071743189, 7011.824704382393, 7023.438124950005, 7024.929750702491, 7031.6484175791265, 1739.9826001739948, 1786.4194136905558, 2010.286348346338, 2059.4542446251717, 2092.5814837032576, 2016.84873634478, 2021.7068525063858, 2023.9291624793136, 2024.2409096588779, 2025.0988310201967, 1967.7638683358018, 2018.798120187984, 2098.3495116513855, 2104.905279262437, 2105.0, 2035.8371330293542, 2055.660815965364, 2072.357569153567, 2092.550101728128, 2093.2045822587397, 2061.721667574888, 2073.232903825579, 2092.4664210626192, 2092.5082605587827, 2094.0262777808393, 6685.0, 6736.6631668416385, 6738.730450781963, 6750.459963202932, 6750.527463077587, 4039.1315867088424, 4109.835606575763, 4126.174765047002, 4127.33962565991, 4128.483939507561, 2272.0798076778765, 2708.4583083383404, 2826.0956493921954, 2834.8724307406214, 2835.773138148943, 780.3601047141346, 783.3576467296818, 830.2818062376001, 878.452487785421, 912.1744820937063, 9231.261499080058, 9234.399764015317, 9241.49171795551, 9242.399244049115, 9257.629694812267, 3880.0881792778673, 3925.823337949799, 3974.324364857981, 3981.0, 3991.660708839723, 7944.84110317802, 7949.841003179904, 7958.283754462126, 7961.601919903982, 7968.561729104955, 4087.5708050654252, 4089.5705950875326, 4103.384492326115, 4105.7331273467125, 4115.9176816463505, 3724.4227144792058, 3759.191773768653, 3759.548854137521, 3760.5487341518647, 3772.320982223226, 2949.454350945082, 3040.3463255400197, 3270.705636492727, 3382.8985130445635, 3412.351653185887, 1054.599252284127, 1054.7099547624312, 1057.5029736024057, 1081.4862940103387, 1083.1118482843992, 737.4466033131522, 759.3621358059256, 759.8936148939152, 817.0522194254636, 938.0525669074284, 6375.0, 6409.262934762469, 6415.101885736, 6437.774677886251, 6439.8068057958335, 987.3434166279487, 1004.5178314409125, 1018.4449475036123, 1018.9184865210765, 1023.3399457349967, 4718.0, 4803.03939212152, 4814.013127308894, 4819.614430845524, 4823.662343635982, 7633.885491717629, 7753.4572579919995, 7841.764747057598, 7865.095514015961, 7876.09424916142, 7902.3678105751405, 7943.920560794318, 7978.920210797934, 7983.281504664492, 7998.280154786097, 6201.410865967726, 6239.126522286883, 6244.719832434431, 6246.593971391845, 6247.219097612799, 5929.6145750526075, 6035.185249991195, 6291.496680265476, 6302.842428939313, 6303.621782693053, 7288.744893928687, 7376.151742549676, 7416.110066792019, 7513.774586762406, 7517.548947063194, 7456.217097204715, 7633.084029916446, 7634.389248860189, 7640.121386040676, 7691.461597688108, 5859.707014649336, 5893.852653683693, 5919.4968427684125, 5920.526357891445, 5923.378045305181, 5381.973090134525, 5485.807996720096, 6129.754809807736, 6208.099825525183, 6276.403741644536, 5875.823725288248, 5949.583529152917, 5997.940020599738, 6030.7286172121485, 6080.48315893154, 5889.175515427929, 5890.0, 5941.31674857397, 5962.25471816023, 6017.518598512196, 5865.706714664335, 5892.6759028253855, 5898.852528686817, 5906.527477801679, 5913.201717768046, 5450.427705090909, 5732.828015159552, 5739.799107031401, 5743.339515955551, 5751.482366587027, 5651.067573850269, 5738.0, 5742.08126699726, 5757.971210143923, 5777.566682498746], "unit": "ms", "name": "mootools.html", "value": 3901.6082155614718}, {"lowerIsBetter": false, "replicates": [305.99388012239757, 312.6857508204254, 314.43401876622085, 316.4241081232157, 318.51744606920505, 5092.541671249587, 5132.358455193101, 5219.921701174486, 5302.628815982887, 5308.309919710442, 5075.695458272507, 5124.92312615311, 5215.58275337972, 5220.8694782630455, 5252.264682944381, 4104.199681062194, 4110.280700877334, 4115.855945041924, 4118.79406029698, 4118.938215926763, 3855.730098893079, 3923.8626648067325, 3989.840406383741, 4062.8984275393054, 4072.3484242521204, 4044.6562042226446, 4064.97967510162, 4077.531083925342, 4088.2028004539125, 4089.631933126018, 4051.4327994080854, 4056.634902858742, 4072.1041370898356, 4082.142750022469, 4085.1829634073006, 3589.174489867345, 3594.245208506217, 3596.892093237207, 3598.442241452553, 3604.9098772530633, 4914.311996320483, 5040.218766091261, 5045.495450454925, 5053.317802096743, 5100.642954993152, 4664.0, 4665.5567721066445, 4668.463126740435, 4675.345451636774, 4680.0639872025395, 5495.313085864267, 5525.364583072957, 5528.917066244009, 5529.087700529408, 5533.22534845122, 3623.1304486923214, 3677.485152078711, 3739.7569158004917, 3766.39737641976, 3774.245150969817, 5704.914426283609, 5769.913451298234, 5780.653160810407, 5781.046127388976, 5789.884202315972, 3974.066094467798, 3979.144483935968, 3981.3629819228786, 3982.422548730418, 3985.940210896839, 4036.3340048891605, 4041.1109555897656, 4045.211183819186, 4045.4134150548007, 4049.8785036448953, 4512.887177820515, 4609.354690343354, 4618.330342100377, 4618.630509559227, 4620.584147426748, 5509.559235261249, 5513.3108361454815, 5514.007478653801, 5514.310711161105, 5527.640703354269, 1411.8658727421084, 1432.641839540115, 1432.7421064208334, 1433.0541842383977, 1433.2332202271734, 958.678842587727, 969.0261287406253, 974.8099120671401, 979.0503211884461, 992.151710287708, 4844.4186697596515, 4859.927101093486, 4864.562189402971, 4864.8783780405065, 4868.099401610713, 5729.197912292282, 5730.942690573041, 5731.197632331477, 5734.455226753452, 5737.3115226172295, 4847.175980083394, 4851.975740121276, 4860.0, 4860.64258834465, 4860.73265970375, 2988.5666578346454, 3072.416240914219, 3094.3501864608684, 3095.659477457478, 3099.6745341738792, 5452.154915988028, 5488.1493368527945, 5490.258815059996, 5492.588055895744, 5493.368262649767, 5936.821895343147, 5944.613600115978, 5945.762169513171, 5950.761969521257, 5953.76184952597, 5450.945490545123, 5471.50756431923, 5483.095289277225, 5485.040117979338, 5493.23094766733, 5641.605087643826, 5783.624064435799, 5793.710314484343, 5794.072948328248, 5795.478406943227, 5428.6199966002005, 5564.165375193753, 5567.276254086943, 5660.886782264414, 5669.829905102853, 5319.920201197063, 5379.35447746273, 5380.946190538045, 5384.461553844584, 5430.891382172414, 3928.0965377962657, 3936.0159960009996, 3946.4474973504307, 3946.4672269244434, 3950.9012274693364, 5754.8273551791835, 5762.567807414377, 5769.653820770767, 5772.076467765138, 5774.9133762994425, 5431.755570999394, 5583.69289689071, 5583.748731307182, 5586.692731899622, 5588.944110558842, 5568.081266590967, 5575.275214222125, 5578.553715702815, 5579.721013949205, 5584.357798853184, 5449.754761035683, 5458.972705136449, 5469.753861076181, 5470.070088084955, 5472.589555783412, 5448.700321482356, 5611.074172761449, 5611.214429979725, 5617.213590097472, 5624.690642014729, 5446.564274857923, 5454.3454785426, 5471.370792358771, 5477.643953143033, 5493.670379777226], "unit": "ms", "name": "prototype.html", "value": 4162.034155376605}, {"lowerIsBetter": false, "replicates": [654.8984907339365, 673.1652750589268, 768.2701433638042, 770.1912991359071, 794.8012996750813, 10829.783404331909, 10940.343579385242, 11031.779364412707, 11034.889651103487, 11035.062019728322, 11535.538578456852, 11630.941845290783, 12801.0, 13216.273104979222, 13218.471261149543, 615.1756646094233, 622.9626222426647, 768.1051574915231, 783.0525064671754, 783.0759703549837, 760.4904713841712, 771.5524995502623, 777.6617171530403, 778.5134291068082, 779.0378882080626, 807.725373373053, 816.3591580609223, 816.3795515408302, 817.060380562355, 817.0644611919349, 636.3159603426312, 645.2321737132797, 799.2606838674203, 808.107041718901, 819.0212695828487, 583.3845293215655, 589.8083122985047, 590.1796502861026, 590.7548367427512, 591.5267785771366, 12529.74940501185, 12531.373431328397, 12548.309842958633, 12552.8117078243, 12566.560170394083, 10976.780464390667, 11107.500162492708, 11522.711932201762, 11592.155848548007, 11748.0, 9315.254779617615, 9458.101480359355, 9517.857232141523, 9527.428354298765, 9675.903240967571, 3334.149791803099, 3376.3416133853907, 3381.5773028371455, 3396.0660818274923, 3462.3767721810063, 42696.78651606722, 43095.138097238196, 43103.56896431027, 43372.566274337165, 43831.12337753259, 9268.72193834186, 9289.674861379819, 9450.52747362643, 9487.857682134774, 9550.761230969143, 15131.394744210329, 15235.0, 15277.465288715064, 15282.694346113016, 15300.311485983157, 6155.630662160284, 6213.37866213375, 6225.439710426083, 6297.622142671455, 6378.872422551523, 3473.0796338970194, 3526.3123690880543, 3543.6102028776813, 3567.090391950036, 3618.7285953553587, 2727.1409506005944, 2771.362586605092, 2775.2229375774414, 2780.124260857823, 2785.5821626756147, 480.39230373576754, 491.6189952786619, 491.6263639633904, 494.57713654825324, 507.13533425509416, 414.4053283538132, 478.63384510849227, 532.6165161084014, 540.699911549094, 552.8756029893242, 7095.991482829442, 7255.982697272047, 7384.261573842573, 7397.0, 7515.511491753128, 382.844947796143, 464.665440882564, 512.1549443418389, 521.4477610460699, 539.0647227061046, 3504.5093686883856, 3523.7885726855957, 3529.435290353531, 3759.3797023491366, 3866.7486613370043, 48586.0, 49741.751291243316, 49906.251406228934, 49931.25103123456, 49951.0, 43955.560444395785, 43980.0, 44654.0, 45904.77047614741, 46097.0, 41782.79108604437, 41868.162636747096, 42063.0, 42101.578984209766, 43530.082292593186, 6578.638174900235, 6619.66901654925, 6641.5207453851735, 6736.562123461959, 6764.830879228059, 32242.193945151557, 32311.35377292488, 32772.34455310833, 33037.66962330346, 33101.0, 36839.0, 36962.26075478529, 37064.0, 41002.38496422496, 41113.79443102765, 8804.691835785718, 9329.807495238749, 9351.766205844908, 9392.154706076486, 9399.20106790903, 10219.59121635156, 10300.536475858455, 10307.94846025765, 10449.58201671955, 10530.526126324487, 9293.117153870371, 9802.607895684092, 9904.059114384121, 9969.102780749767, 10078.294519383866, 9813.852792208265, 9887.110160085627, 9896.20830333586, 9909.405435673594, 10050.798984020132, 8194.0, 9491.525423728648, 9756.414615123116, 9894.109530142034, 9917.206623470249, 8233.46482478637, 8311.792205194919, 8395.95802020986, 8558.400911936105, 8583.098774628574, 8057.5165490070785, 8457.0, 8497.87253191215, 8566.217509169312, 8609.311255099452], "unit": "ms", "name": "yui.html", "value": 5532.350758261655}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 106.0, 113.0, 112.0, 113.0, 102.0, 112.0, 112.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 158.0, 163.0, 130.0, 156.0, 163.0, 132.0, 163.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 160.0, 161.0, 159.0, 162.0, 163.0, 162.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 84.0, 93.0, 71.0, 73.0, 72.0, 94.0, 98.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [95.0, 105.0, 138.0, 93.0, 94.0, 95.0, 136.0, 94.0, 94.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 97.0, 95.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 72.0, 70.0, 71.0, 71.0, 76.0, 71.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 69.0, 68.0, 68.0, 67.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 82.0, 93.0, 84.0, 85.0, 85.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [127.0, 128.0, 125.0, 118.0, 126.0, 126.0, 122.0, 135.0, 125.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [151.0, 140.0, 152.0, 147.0, 148.0, 148.0, 160.0, 146.0, 164.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 67.0, 67.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.66326362588507], "unit": "score", "name": "Richards", "value": 214.38904599999995}, {"lowerIsBetter": false, "replicates": [193.91118867558657], "unit": "score", "name": "DeltaBlue", "value": 340.97052599999995}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1970.4724409448818], "unit": "score", "name": "RayTrace", "value": 375.5388731268733}, {"lowerIsBetter": false, "replicates": [805.8017727639001], "unit": "score", "name": "Earley", "value": 827.0805830000004}, {"lowerIsBetter": false, "replicates": [12481.481481481482], "unit": "score", "name": "Boyer", "value": 53.39614540059344}, {"lowerIsBetter": false, "replicates": [27054.054054054053], "unit": "score", "name": "RegExp", "value": 33.67277222777225}, {"lowerIsBetter": false, "replicates": [609.3845216331505], "unit": "score", "name": "Splay", "value": 133.72673099999997}, {"lowerIsBetter": false, "replicates": [4887.804878048781], "unit": "score", "name": "NavierStokes", "value": 303.61277445109783}], "name": "v8_7"}]} 05:12:47 INFO - RETURN: dromaeo_css: 6111.30 05:12:47 INFO - RETURN: kraken: 1524.00 05:12:47 INFO - RETURN: v8_7: 19625.54 05:12:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19625.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1524.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6111.30"}}} 05:12:47 INFO - Return code: 0 05:12:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:12:47 INFO - # TBPL SUCCESS # 05:12:47 INFO - Running post-action listener: _resource_record_post_action 05:12:47 INFO - Running post-run listener: _resource_record_post_run 05:12:48 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 8192; Write bytes: 514154496; Read time: 132; Write time: 476336 05:12:48 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 239591424; Read time: 0; Write time: 302296 05:12:48 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274563072; Read time: 108; Write time: 174040 05:12:48 INFO - Running post-run listener: _upload_blobber_files 05:12:48 INFO - Blob upload gear active. 05:12:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:12:48 INFO - Copying logs to upload dir... 05:12:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.538947 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-25 05:12:48.763168) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 05:12:48.766721) ========= 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=a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009982 build_url: 'https://queue.taskcluster.net/v1/task/jcfujDUgRUmZFcflr8F7Zw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 05:12:48.822190) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:12:48.822562) ========= 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=a9e534cca236dfa67d42a089000001c1-1448451809.41818-1836249242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 05:12:48.872958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 05:12:48.873274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 05:12:48.873579) ========= ========= Total master_lag: 0.27 =========