builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1449231960.66 results: success (0) buildid: 20151204025717 builduid: 5f2df271dc324214adb2143de4cc12cc revision: a36cc9262f70b95c830ce1ff3bd415f346b46415 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.660688) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.661116) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.661450) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006433 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.696411) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.696772) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.726178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.726554) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.776366) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.776705) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.777104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.777419) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 04:26:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.6M=0s 2015-12-04 04:26:01 (83.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173635 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.965522) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:00.965881) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019006 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:01.016088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:01.016462) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a36cc9262f70b95c830ce1ff3bd415f346b46415 --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 a36cc9262f70b95c830ce1ff3bd415f346b46415 --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=fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 04:26:01,524 truncating revision to first 12 chars 2015-12-04 04:26:01,524 Setting DEBUG logging. 2015-12-04 04:26:01,525 attempt 1/10 2015-12-04 04:26:01,525 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a36cc9262f70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 04:26:01,807 unpacking tar archive at: mozilla-central-a36cc9262f70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550437 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:01.583657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:01.584127) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:01.594722) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:01.595154) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 04:26:01.595737) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-12-04 04:26:01.596094) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:26:02 INFO - MultiFileLogger online at 20151204 04:26:02 in /builds/slave/test 04:26:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:26:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:02 INFO - {'append_to_log': False, 04:26:02 INFO - 'base_work_dir': '/builds/slave/test', 04:26:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:26:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:02 INFO - 'branch': 'Firefox-Non-PGO', 04:26:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:02 INFO - 'config_files': ('talos/linux_config.py',), 04:26:02 INFO - 'default_actions': ('clobber', 04:26:02 INFO - 'read-buildbot-config', 04:26:02 INFO - 'download-and-extract', 04:26:02 INFO - 'populate-webroot', 04:26:02 INFO - 'create-virtualenv', 04:26:02 INFO - 'install', 04:26:02 INFO - 'run-tests'), 04:26:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:02 INFO - 'download_minidump_stackwalk': True, 04:26:02 INFO - 'download_symbols': 'ondemand', 04:26:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:02 INFO - 'installer_path': 'installer.exe', 04:26:02 INFO - 'log_level': 'info', 04:26:02 INFO - 'log_name': 'talos', 04:26:02 INFO - 'log_to_console': True, 04:26:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:26:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:26:02 INFO - 'opt_config_files': (), 04:26:02 INFO - 'pip_index': False, 04:26:02 INFO - 'sps_profile': False, 04:26:02 INFO - 'sps_profile_interval': 0, 04:26:02 INFO - 'suite': 'dromaeojs-e10s', 04:26:02 INFO - 'system_bits': '64', 04:26:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:02 INFO - 'title': 'talos-linux64-ix-020', 04:26:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:02 INFO - 'use_talos_json': True, 04:26:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:02 INFO - 'work_dir': 'build'} 04:26:02 INFO - ##### 04:26:02 INFO - ##### Running clobber step. 04:26:02 INFO - ##### 04:26:02 INFO - Running pre-action listener: _resource_record_pre_action 04:26:02 INFO - Running main action method: clobber 04:26:02 INFO - rmtree: /builds/slave/test/build 04:26:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:03 INFO - Running post-action listener: _resource_record_post_action 04:26:03 INFO - ##### 04:26:03 INFO - ##### Running read-buildbot-config step. 04:26:03 INFO - ##### 04:26:03 INFO - Running pre-action listener: _resource_record_pre_action 04:26:03 INFO - Running main action method: read_buildbot_config 04:26:03 INFO - Using buildbot properties: 04:26:03 INFO - { 04:26:03 INFO - "properties": { 04:26:03 INFO - "buildnumber": 132, 04:26:03 INFO - "product": "firefox", 04:26:03 INFO - "script_repo_revision": "production", 04:26:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:26:03 INFO - "repository": "", 04:26:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:26:03 INFO - "buildid": "20151204025717", 04:26:03 INFO - "slavename": "talos-linux64-ix-020", 04:26:03 INFO - "pgo_build": "False", 04:26:03 INFO - "basedir": "/builds/slave/test", 04:26:03 INFO - "project": "", 04:26:03 INFO - "platform": "ubuntu64_hw", 04:26:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:26:03 INFO - "slavebuilddir": "test", 04:26:03 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:26:03 INFO - "branch": "mozilla-central", 04:26:03 INFO - "repo_path": "mozilla-central", 04:26:03 INFO - "stage_platform": "linux64", 04:26:03 INFO - "builduid": "5f2df271dc324214adb2143de4cc12cc", 04:26:03 INFO - "revision": "a36cc9262f70b95c830ce1ff3bd415f346b46415" 04:26:03 INFO - }, 04:26:03 INFO - "sourcestamp": { 04:26:03 INFO - "repository": "", 04:26:03 INFO - "hasPatch": false, 04:26:03 INFO - "project": "", 04:26:03 INFO - "branch": "mozilla-central-linux64-talos", 04:26:03 INFO - "changes": [ 04:26:03 INFO - { 04:26:03 INFO - "category": null, 04:26:03 INFO - "files": [ 04:26:03 INFO - { 04:26:03 INFO - "url": null, 04:26:03 INFO - "name": "https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:26:03 INFO - } 04:26:03 INFO - ], 04:26:03 INFO - "repository": "", 04:26:03 INFO - "rev": "a36cc9262f70b95c830ce1ff3bd415f346b46415", 04:26:03 INFO - "who": "cbook@mozilla.com", 04:26:03 INFO - "when": 1449231905, 04:26:03 INFO - "number": 6743900, 04:26:03 INFO - "comments": "merge fx-team to mozilla-central a=merge", 04:26:03 INFO - "project": "", 04:26:03 INFO - "at": "Fri 04 Dec 2015 04:25:05", 04:26:03 INFO - "branch": "mozilla-central-linux64-talos", 04:26:03 INFO - "revlink": "", 04:26:03 INFO - "properties": [ 04:26:03 INFO - [ 04:26:03 INFO - "buildid", 04:26:03 INFO - "20151204025717", 04:26:03 INFO - "Change" 04:26:03 INFO - ], 04:26:03 INFO - [ 04:26:03 INFO - "builduid", 04:26:03 INFO - "5f2df271dc324214adb2143de4cc12cc", 04:26:03 INFO - "Change" 04:26:03 INFO - ], 04:26:03 INFO - [ 04:26:03 INFO - "pgo_build", 04:26:03 INFO - "False", 04:26:03 INFO - "Change" 04:26:03 INFO - ] 04:26:03 INFO - ], 04:26:03 INFO - "revision": "a36cc9262f70b95c830ce1ff3bd415f346b46415" 04:26:03 INFO - } 04:26:03 INFO - ], 04:26:03 INFO - "revision": "a36cc9262f70b95c830ce1ff3bd415f346b46415" 04:26:03 INFO - } 04:26:03 INFO - } 04:26:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:26:03 INFO - Running post-action listener: _resource_record_post_action 04:26:03 INFO - ##### 04:26:03 INFO - ##### Running download-and-extract step. 04:26:03 INFO - ##### 04:26:03 INFO - Running pre-action listener: _resource_record_pre_action 04:26:03 INFO - Running main action method: download_and_extract 04:26:03 INFO - mkdir: /builds/slave/test/build/tests 04:26: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:26:03 INFO - https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:26:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/test_packages.json 04:26:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/test_packages.json 04:26:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:26:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:26:06 INFO - Downloaded 1302 bytes. 04:26:06 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:26:06 INFO - Using the following test package requirements: 04:26:06 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:06 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:26:06 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:06 INFO - u'jsshell-linux-x86_64.zip'], 04:26:06 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:26:06 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:06 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:26:06 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:26:06 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:26:06 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:26:06 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:26:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:26:06 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:26: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:26:06 INFO - https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:14 INFO - Downloaded 21791534 bytes. 04:26:14 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:26:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:14 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:26:15 INFO - Return code: 0 04:26:15 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:26:15 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:26:15 INFO - https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:26:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:25 INFO - Downloaded 21791534 bytes. 04:26:25 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:26:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:26:25 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:26:26 INFO - Return code: 0 04:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:26 INFO - https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:26:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:27 INFO - Downloaded 11132001 bytes. 04:26:27 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:26:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:26:27 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:26:27 INFO - Return code: 0 04:26:27 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:26:27 INFO - https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:26:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:26:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:26:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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:26:30 INFO - Downloaded 57695064 bytes. 04:26:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:26:30 INFO - mkdir: /builds/slave/test/properties 04:26:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:26:30 INFO - Writing to file /builds/slave/test/properties/build_url 04:26:30 INFO - Contents: 04:26:30 INFO - build_url:https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:26:30 INFO - Running post-action listener: _resource_record_post_action 04:26:30 INFO - Running post-action listener: set_extra_try_arguments 04:26:30 INFO - ##### 04:26:30 INFO - ##### Running populate-webroot step. 04:26:30 INFO - ##### 04:26:30 INFO - Running pre-action listener: _resource_record_pre_action 04:26:30 INFO - Running main action method: populate_webroot 04:26:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:26:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:26:30 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:26:30 INFO - '../fennec_ids.txt'], 04:26:30 INFO - 'tests': ['tcheck2']}, 04:26:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:26:30 INFO - '--tppagecycles', 04:26:30 INFO - '7'], 04:26:30 INFO - 'tests': ['tsvgm']}}, 04:26:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:26:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:26:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:26:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:26:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:26:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:26:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:30 INFO - 'talos_options': ['--e10s'], 04:26:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:30 INFO - 'tests': ['damp', 'tps']}, 04:26:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:30 INFO - 'talos_options': ['--e10s'], 04:26:30 INFO - 'tests': ['damp', 'tps']}, 04:26:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:26:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:26:30 INFO - 'other': {'tests': ['a11yr', 04:26:30 INFO - 'ts_paint', 04:26:30 INFO - 'tpaint', 04:26:30 INFO - 'sessionrestore', 04:26:30 INFO - 'sessionrestore_no_auto_restore']}, 04:26:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:26:30 INFO - 'tests': ['a11yr', 04:26:30 INFO - 'ts_paint', 04:26:30 INFO - 'tpaint', 04:26:30 INFO - 'sessionrestore', 04:26:30 INFO - 'sessionrestore_no_auto_restore']}, 04:26:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:26:30 INFO - 'tests': ['a11yr', 04:26:30 INFO - 'ts_paint', 04:26:30 INFO - 'tpaint', 04:26:30 INFO - 'sessionrestore', 04:26:30 INFO - 'sessionrestore_no_auto_restore']}, 04:26:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:26:30 INFO - 'tests': ['a11yr', 04:26:30 INFO - 'ts_paint', 04:26:30 INFO - 'tpaint', 04:26:30 INFO - 'sessionrestore', 04:26:30 INFO - 'sessionrestore_no_auto_restore']}, 04:26:30 INFO - 'other_l64': {'tests': ['a11yr', 04:26:30 INFO - 'ts_paint', 04:26:30 INFO - 'tpaint', 04:26:30 INFO - 'sessionrestore', 04:26:30 INFO - 'sessionrestore_no_auto_restore']}, 04:26:30 INFO - 'other_nol64': {'tests': ['a11yr', 04:26:30 INFO - 'ts_paint', 04:26:30 INFO - 'tpaint', 04:26:30 INFO - 'sessionrestore', 04:26:30 INFO - 'sessionrestore_no_auto_restore']}, 04:26:30 INFO - 'svgr': {'tests': ['tsvgx', 04:26:30 INFO - 'tsvgr_opacity', 04:26:30 INFO - 'tart', 04:26:30 INFO - 'tscrollx', 04:26:30 INFO - 'cart']}, 04:26:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:26:30 INFO - 'tests': ['tsvgx', 04:26:30 INFO - 'tsvgr_opacity', 04:26:30 INFO - 'tart', 04:26:30 INFO - 'tscrollx', 04:26:30 INFO - 'cart']}, 04:26:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:30 INFO - 'tests': ['tp5o']}, 04:26:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:30 INFO - 'talos_options': ['--e10s'], 04:26:30 INFO - 'tests': ['tp5o']}, 04:26:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:30 INFO - 'talos_options': ['--xperf_path', 04:26:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:30 INFO - 'tests': ['tp5n']}, 04:26:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:26:30 INFO - 'talos_options': ['--e10s', 04:26:30 INFO - '--xperf_path', 04:26:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:30 INFO - 'tests': ['tp5n']}}, 04:26:30 INFO - 'talos.zip': {'path': '', 04:26:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:26:30 INFO - Running post-action listener: _resource_record_post_action 04:26:30 INFO - ##### 04:26:30 INFO - ##### Running create-virtualenv step. 04:26:30 INFO - ##### 04:26:30 INFO - Running pre-action listener: _resource_record_pre_action 04:26:30 INFO - Running main action method: create_virtualenv 04:26:30 INFO - Creating virtualenv /builds/slave/test/build/venv 04:26:30 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:26:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:26:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:26:30 INFO - Using real prefix '/usr' 04:26:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:26:31 INFO - Installing distribute.............................................................................................................................................................................................done. 04:26:33 INFO - Installing pip.................done. 04:26:33 INFO - Return code: 0 04:26:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:26:33 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:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:33 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:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:33 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 0x7f60f2803f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a580b0>, '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 0x2a58fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', '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:26:33 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:26:33 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:26:33 INFO - Using env: {'DISPLAY': ':0', 04:26:33 INFO - 'HOME': '/home/cltbld', 04:26:33 INFO - 'LANG': 'en_US.UTF-8', 04:26:33 INFO - 'LANGUAGE': 'en_US:en', 04:26:33 INFO - 'LOGNAME': 'cltbld', 04:26:33 INFO - 'MAIL': '/var/mail/cltbld', 04:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:33 INFO - 'MOZ_NO_REMOTE': '1', 04:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:33 INFO - 'NO_EM_RESTART': '1', 04:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:33 INFO - 'PWD': '/builds/slave/test', 04:26:33 INFO - 'SHELL': '/bin/bash', 04:26:33 INFO - 'SHLVL': '1', 04:26:33 INFO - 'TERM': 'linux', 04:26:33 INFO - 'TMOUT': '86400', 04:26:33 INFO - 'USER': 'cltbld', 04:26:33 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', 04:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:33 INFO - '_': '/tools/buildbot/bin/python'} 04:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:33 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:26:33 INFO - Cleaning up... 04:26:33 INFO - Return code: 0 04:26:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:26:33 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:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:33 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:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:33 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 0x7f60f2803f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a580b0>, '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 0x2a58fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', '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:26:33 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:26:33 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:26:33 INFO - Using env: {'DISPLAY': ':0', 04:26:33 INFO - 'HOME': '/home/cltbld', 04:26:33 INFO - 'LANG': 'en_US.UTF-8', 04:26:33 INFO - 'LANGUAGE': 'en_US:en', 04:26:33 INFO - 'LOGNAME': 'cltbld', 04:26:33 INFO - 'MAIL': '/var/mail/cltbld', 04:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:33 INFO - 'MOZ_NO_REMOTE': '1', 04:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:33 INFO - 'NO_EM_RESTART': '1', 04:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:33 INFO - 'PWD': '/builds/slave/test', 04:26:33 INFO - 'SHELL': '/bin/bash', 04:26:33 INFO - 'SHLVL': '1', 04:26:33 INFO - 'TERM': 'linux', 04:26:33 INFO - 'TMOUT': '86400', 04:26:33 INFO - 'USER': 'cltbld', 04:26:33 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', 04:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:33 INFO - '_': '/tools/buildbot/bin/python'} 04:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:33 INFO - Downloading/unpacking psutil>=0.7.1 04:26:33 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:26:33 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:26:33 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:26:33 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:26:33 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:26:33 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:26:35 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:26:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:26:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:35 INFO - Installing collected packages: psutil 04:26:35 INFO - Running setup.py install for psutil 04:26:35 INFO - building 'psutil._psutil_linux' extension 04:26:35 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:26:35 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:26:35 INFO - building 'psutil._psutil_posix' extension 04:26:35 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:26:35 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:26:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:36 INFO - Successfully installed psutil 04:26:36 INFO - Cleaning up... 04:26:36 INFO - Return code: 0 04:26:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:26:36 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:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:36 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:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:36 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 0x7f60f2803f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a580b0>, '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 0x2a58fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', '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:26:36 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:26:36 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:26:36 INFO - Using env: {'DISPLAY': ':0', 04:26:36 INFO - 'HOME': '/home/cltbld', 04:26:36 INFO - 'LANG': 'en_US.UTF-8', 04:26:36 INFO - 'LANGUAGE': 'en_US:en', 04:26:36 INFO - 'LOGNAME': 'cltbld', 04:26:36 INFO - 'MAIL': '/var/mail/cltbld', 04:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:36 INFO - 'MOZ_NO_REMOTE': '1', 04:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:36 INFO - 'NO_EM_RESTART': '1', 04:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:36 INFO - 'PWD': '/builds/slave/test', 04:26:36 INFO - 'SHELL': '/bin/bash', 04:26:36 INFO - 'SHLVL': '1', 04:26:36 INFO - 'TERM': 'linux', 04:26:36 INFO - 'TMOUT': '86400', 04:26:36 INFO - 'USER': 'cltbld', 04:26:36 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', 04:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:36 INFO - '_': '/tools/buildbot/bin/python'} 04:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:26:36 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:26:36 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:26:36 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:26:36 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:26:36 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:26:36 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:26:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:26:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:26:38 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:26:38 INFO - Installing collected packages: mozsystemmonitor 04:26:38 INFO - Running setup.py install for mozsystemmonitor 04:26:38 INFO - Successfully installed mozsystemmonitor 04:26:38 INFO - Cleaning up... 04:26:38 INFO - Return code: 0 04:26:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:38 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 0x7f60f2803f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a580b0>, '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 0x2a58fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', '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:26:38 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:26:38 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:26:38 INFO - Using env: {'DISPLAY': ':0', 04:26:38 INFO - 'HOME': '/home/cltbld', 04:26:38 INFO - 'LANG': 'en_US.UTF-8', 04:26:38 INFO - 'LANGUAGE': 'en_US:en', 04:26:38 INFO - 'LOGNAME': 'cltbld', 04:26:38 INFO - 'MAIL': '/var/mail/cltbld', 04:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:38 INFO - 'MOZ_NO_REMOTE': '1', 04:26:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:38 INFO - 'NO_EM_RESTART': '1', 04:26:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:38 INFO - 'PWD': '/builds/slave/test', 04:26:38 INFO - 'SHELL': '/bin/bash', 04:26:38 INFO - 'SHLVL': '1', 04:26:38 INFO - 'TERM': 'linux', 04:26:38 INFO - 'TMOUT': '86400', 04:26:38 INFO - 'USER': 'cltbld', 04:26:38 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', 04:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:38 INFO - '_': '/tools/buildbot/bin/python'} 04:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:38 INFO - Downloading/unpacking blobuploader==1.2.4 04:26:38 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:26:38 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:26:38 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:26:38 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:26:38 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:26:38 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:26:40 INFO - Downloading blobuploader-1.2.4.tar.gz 04:26:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:26:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:26:40 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:26:40 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:26:40 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:26:40 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:26:40 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:26:40 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:26:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:26:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:26:40 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:26:40 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:26:40 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:26:40 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:26:40 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:26:40 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:26:40 INFO - Downloading docopt-0.6.1.tar.gz 04:26:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:26:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:26:40 INFO - Running setup.py install for blobuploader 04:26:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:26:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:26:40 INFO - Running setup.py install for requests 04:26:41 INFO - Running setup.py install for docopt 04:26:41 INFO - Successfully installed blobuploader requests docopt 04:26:41 INFO - Cleaning up... 04:26:41 INFO - Return code: 0 04:26:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:41 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 0x7f60f2803f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a580b0>, '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 0x2a58fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', '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:26:41 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:26:41 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:26:41 INFO - Using env: {'DISPLAY': ':0', 04:26:41 INFO - 'HOME': '/home/cltbld', 04:26:41 INFO - 'LANG': 'en_US.UTF-8', 04:26:41 INFO - 'LANGUAGE': 'en_US:en', 04:26:41 INFO - 'LOGNAME': 'cltbld', 04:26:41 INFO - 'MAIL': '/var/mail/cltbld', 04:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:41 INFO - 'MOZ_NO_REMOTE': '1', 04:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:41 INFO - 'NO_EM_RESTART': '1', 04:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:41 INFO - 'PWD': '/builds/slave/test', 04:26:41 INFO - 'SHELL': '/bin/bash', 04:26:41 INFO - 'SHLVL': '1', 04:26:41 INFO - 'TERM': 'linux', 04:26:41 INFO - 'TMOUT': '86400', 04:26:41 INFO - 'USER': 'cltbld', 04:26:41 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', 04:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:41 INFO - '_': '/tools/buildbot/bin/python'} 04:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:41 INFO - Running setup.py (path:/tmp/pip-ESFMwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:41 INFO - Running setup.py (path:/tmp/pip-fR8dpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:41 INFO - Running setup.py (path:/tmp/pip-e0qAtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:41 INFO - Running setup.py (path:/tmp/pip-qnVXad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:41 INFO - Running setup.py (path:/tmp/pip-ym88cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:42 INFO - Running setup.py (path:/tmp/pip-OCBB_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:42 INFO - Running setup.py (path:/tmp/pip-APBvUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:42 INFO - Running setup.py (path:/tmp/pip-PHOaEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:42 INFO - Running setup.py (path:/tmp/pip-yKLY84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:42 INFO - Running setup.py (path:/tmp/pip-USG57T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:42 INFO - Running setup.py (path:/tmp/pip-UvN0wY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:42 INFO - Running setup.py (path:/tmp/pip-0W3UcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:42 INFO - Running setup.py (path:/tmp/pip-w7O9qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:42 INFO - Running setup.py (path:/tmp/pip-8Ija15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:42 INFO - Running setup.py (path:/tmp/pip-S6oTuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:42 INFO - Running setup.py (path:/tmp/pip-tX9soT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:42 INFO - Running setup.py (path:/tmp/pip-a3dZC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:26:42 INFO - Running setup.py install for manifestparser 04:26:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:26:42 INFO - Running setup.py install for mozcrash 04:26:43 INFO - Running setup.py install for mozdebug 04:26:43 INFO - Running setup.py install for mozdevice 04:26:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:26:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:26:43 INFO - Running setup.py install for mozfile 04:26:43 INFO - Running setup.py install for mozhttpd 04:26:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:26:43 INFO - Running setup.py install for mozinfo 04:26:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:26:43 INFO - Running setup.py install for mozInstall 04:26:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:26:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:26:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:26:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:26:43 INFO - Running setup.py install for mozleak 04:26:43 INFO - Running setup.py install for mozlog 04:26:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:26:43 INFO - Running setup.py install for moznetwork 04:26:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:26:43 INFO - Running setup.py install for mozprocess 04:26:44 INFO - Running setup.py install for mozprofile 04:26:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:26:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:26:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:26:44 INFO - Running setup.py install for mozrunner 04:26:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:26:44 INFO - Running setup.py install for mozscreenshot 04:26:44 INFO - Running setup.py install for moztest 04:26:44 INFO - Running setup.py install for mozversion 04:26:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:26:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:26:44 INFO - Cleaning up... 04:26:44 INFO - Return code: 0 04:26:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26: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:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:44 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 0x7f60f2803f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a580b0>, '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 0x2a58fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', '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:26:44 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:26:44 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:26:44 INFO - Using env: {'DISPLAY': ':0', 04:26:44 INFO - 'HOME': '/home/cltbld', 04:26:44 INFO - 'LANG': 'en_US.UTF-8', 04:26:44 INFO - 'LANGUAGE': 'en_US:en', 04:26:44 INFO - 'LOGNAME': 'cltbld', 04:26:44 INFO - 'MAIL': '/var/mail/cltbld', 04:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:44 INFO - 'MOZ_NO_REMOTE': '1', 04:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:44 INFO - 'NO_EM_RESTART': '1', 04:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:44 INFO - 'PWD': '/builds/slave/test', 04:26:44 INFO - 'SHELL': '/bin/bash', 04:26:44 INFO - 'SHLVL': '1', 04:26:44 INFO - 'TERM': 'linux', 04:26:44 INFO - 'TMOUT': '86400', 04:26:44 INFO - 'USER': 'cltbld', 04:26:44 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', 04:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:44 INFO - '_': '/tools/buildbot/bin/python'} 04:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:44 INFO - Running setup.py (path:/tmp/pip-K4EB71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:44 INFO - Running setup.py (path:/tmp/pip-J2cJP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:44 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:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:44 INFO - Running setup.py (path:/tmp/pip-XuIzU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:45 INFO - Running setup.py (path:/tmp/pip-fMKyTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:45 INFO - Running setup.py (path:/tmp/pip-_rFSIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:45 INFO - Running setup.py (path:/tmp/pip-zEK8sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:45 INFO - Running setup.py (path:/tmp/pip-aQefaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:45 INFO - Running setup.py (path:/tmp/pip-a1sefE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:45 INFO - Running setup.py (path:/tmp/pip-CjHtIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:45 INFO - Running setup.py (path:/tmp/pip-dvIqp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:45 INFO - Running setup.py (path:/tmp/pip-ipMZ6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:45 INFO - Running setup.py (path:/tmp/pip-HyCggn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:45 INFO - Running setup.py (path:/tmp/pip-zEUUji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:45 INFO - Running setup.py (path:/tmp/pip-0ffkWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:45 INFO - Running setup.py (path:/tmp/pip-6wTyBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:45 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:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:45 INFO - Running setup.py (path:/tmp/pip-gEX47v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:46 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:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:46 INFO - Running setup.py (path:/tmp/pip-XkDL6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:47 INFO - Downloading blessings-1.5.1.tar.gz 04:26:47 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:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:47 INFO - Installing collected packages: blessings 04:26:47 INFO - Running setup.py install for blessings 04:26:47 INFO - Successfully installed blessings 04:26:47 INFO - Cleaning up... 04:26:47 INFO - Return code: 0 04:26:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:48 INFO - Reading from file tmpfile_stdout 04:26:48 INFO - Current package versions: 04:26:48 INFO - argparse == 1.2.1 04:26:48 INFO - blessings == 1.5.1 04:26:48 INFO - blobuploader == 1.2.4 04:26:48 INFO - docopt == 0.6.1 04:26:48 INFO - manifestparser == 1.1 04:26:48 INFO - mozInstall == 1.12 04:26:48 INFO - mozcrash == 0.16 04:26:48 INFO - mozdebug == 0.1 04:26:48 INFO - mozdevice == 0.47 04:26:48 INFO - mozfile == 1.2 04:26:48 INFO - mozhttpd == 0.7 04:26:48 INFO - mozinfo == 0.9 04:26:48 INFO - mozleak == 0.1 04:26:48 INFO - mozlog == 3.1 04:26:48 INFO - moznetwork == 0.27 04:26:48 INFO - mozprocess == 0.22 04:26:48 INFO - mozprofile == 0.27 04:26:48 INFO - mozrunner == 6.11 04:26:48 INFO - mozscreenshot == 0.1 04:26:48 INFO - mozsystemmonitor == 0.0 04:26:48 INFO - moztest == 0.7 04:26:48 INFO - mozversion == 1.4 04:26:48 INFO - psutil == 3.1.1 04:26:48 INFO - requests == 1.2.3 04:26:48 INFO - wsgiref == 0.1.2 04:26:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:48 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 0x7f60f2803f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a580b0>, '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 0x2a58fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', '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:26:48 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:26:48 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:26:48 INFO - Using env: {'DISPLAY': ':0', 04:26:48 INFO - 'HOME': '/home/cltbld', 04:26:48 INFO - 'LANG': 'en_US.UTF-8', 04:26:48 INFO - 'LANGUAGE': 'en_US:en', 04:26:48 INFO - 'LOGNAME': 'cltbld', 04:26:48 INFO - 'MAIL': '/var/mail/cltbld', 04:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:48 INFO - 'MOZ_NO_REMOTE': '1', 04:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:48 INFO - 'NO_EM_RESTART': '1', 04:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:48 INFO - 'PWD': '/builds/slave/test', 04:26:48 INFO - 'SHELL': '/bin/bash', 04:26:48 INFO - 'SHLVL': '1', 04:26:48 INFO - 'TERM': 'linux', 04:26:48 INFO - 'TMOUT': '86400', 04:26:48 INFO - 'USER': 'cltbld', 04:26:48 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', 04:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:48 INFO - '_': '/tools/buildbot/bin/python'} 04:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 INFO - Cleaning up... 04:26:48 INFO - Return code: 0 04:26:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:48 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 0x7f60f2803f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a580b0>, '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 0x2a58fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', '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:26:48 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:26:48 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:26:48 INFO - Using env: {'DISPLAY': ':0', 04:26:48 INFO - 'HOME': '/home/cltbld', 04:26:48 INFO - 'LANG': 'en_US.UTF-8', 04:26:48 INFO - 'LANGUAGE': 'en_US:en', 04:26:48 INFO - 'LOGNAME': 'cltbld', 04:26:48 INFO - 'MAIL': '/var/mail/cltbld', 04:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:48 INFO - 'MOZ_NO_REMOTE': '1', 04:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:48 INFO - 'NO_EM_RESTART': '1', 04:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:48 INFO - 'PWD': '/builds/slave/test', 04:26:48 INFO - 'SHELL': '/bin/bash', 04:26:48 INFO - 'SHLVL': '1', 04:26:48 INFO - 'TERM': 'linux', 04:26:48 INFO - 'TMOUT': '86400', 04:26:48 INFO - 'USER': 'cltbld', 04:26:48 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', 04:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:48 INFO - '_': '/tools/buildbot/bin/python'} 04:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:48 INFO - Downloading/unpacking jsonschema 04:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:48 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:26:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:26:50 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:26:50 INFO - Downloading/unpacking functools32 (from jsonschema) 04:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:50 INFO - Downloading functools32-3.2.3-2.tar.gz 04:26:50 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:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:26:50 INFO - warning: no files found matching '*.txt' 04:26:50 INFO - no previously-included directories found matching 'build' 04:26:50 INFO - no previously-included directories found matching 'dist' 04:26:50 INFO - no previously-included directories found matching '.git*' 04:26:50 INFO - Installing collected packages: jsonschema, functools32 04:26:50 INFO - Running setup.py install for functools32 04:26:50 INFO - warning: no files found matching '*.txt' 04:26:50 INFO - no previously-included directories found matching 'build' 04:26:50 INFO - no previously-included directories found matching 'dist' 04:26:50 INFO - no previously-included directories found matching '.git*' 04:26:50 INFO - Successfully installed jsonschema functools32 04:26:50 INFO - Cleaning up... 04:26:50 INFO - Return code: 0 04:26:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:26: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:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f60f2803f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c9240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a580b0>, '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 0x2a58fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59440>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', '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:26:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:26:50 INFO - Using env: {'DISPLAY': ':0', 04:26:50 INFO - 'HOME': '/home/cltbld', 04:26:50 INFO - 'LANG': 'en_US.UTF-8', 04:26:50 INFO - 'LANGUAGE': 'en_US:en', 04:26:50 INFO - 'LOGNAME': 'cltbld', 04:26:50 INFO - 'MAIL': '/var/mail/cltbld', 04:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:50 INFO - 'MOZ_NO_REMOTE': '1', 04:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:26:50 INFO - 'NO_EM_RESTART': '1', 04:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:50 INFO - 'PWD': '/builds/slave/test', 04:26:50 INFO - 'SHELL': '/bin/bash', 04:26:50 INFO - 'SHLVL': '1', 04:26:50 INFO - 'TERM': 'linux', 04:26:50 INFO - 'TMOUT': '86400', 04:26:50 INFO - 'USER': 'cltbld', 04:26:50 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', 04:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:50 INFO - '_': '/tools/buildbot/bin/python'} 04:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:51 INFO - Downloading/unpacking flake8 04:26:51 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:26:51 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:26:51 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:26:51 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:26:51 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:26:51 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:26:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:26:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:26:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:26:52 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:26:52 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:26:52 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:26:52 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:26:52 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:26:52 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:26:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:26:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:26:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:26:52 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:26:52 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:26:52 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:26:52 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:26:52 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:26:52 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:26:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:26:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:26:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:26:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:26:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:26:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:26:53 INFO - no previously-included directories found matching 'docs/_build' 04:26:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:26:53 INFO - Running setup.py install for pep8 04:26:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:26:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:26:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:26:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:26:53 INFO - no previously-included directories found matching 'docs/_build' 04:26:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:26:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:26:53 INFO - Cleaning up... 04:26:53 INFO - Return code: 0 04:26:53 INFO - Running post-action listener: _resource_record_post_action 04:26:53 INFO - Running post-action listener: _start_resource_monitoring 04:26:53 INFO - Starting resource monitoring. 04:26:53 INFO - ##### 04:26:53 INFO - ##### Running install step. 04:26:53 INFO - ##### 04:26:53 INFO - Running pre-action listener: _resource_record_pre_action 04:26:53 INFO - Running main action method: install 04:26:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:53 INFO - Reading from file tmpfile_stdout 04:26:53 INFO - Detecting whether we're running mozinstall >=1.0... 04:26:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:26:53 INFO - Reading from file tmpfile_stdout 04:26:53 INFO - Output received: 04:26:53 INFO - Usage: mozinstall [options] installer 04:26:53 INFO - Options: 04:26:53 INFO - -h, --help show this help message and exit 04:26:53 INFO - -d DEST, --destination=DEST 04:26:53 INFO - Directory to install application into. [default: 04:26:53 INFO - "/builds/slave/test"] 04:26:53 INFO - --app=APP Application being installed. [default: firefox] 04:26:53 INFO - mkdir: /builds/slave/test/build/application 04:26:53 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:26:53 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:27:08 INFO - Reading from file tmpfile_stdout 04:27:08 INFO - Output received: 04:27:08 INFO - /builds/slave/test/build/application/firefox/firefox 04:27:08 INFO - Running post-action listener: _resource_record_post_action 04:27:08 INFO - ##### 04:27:08 INFO - ##### Running run-tests step. 04:27:08 INFO - ##### 04:27:08 INFO - Running pre-action listener: _resource_record_pre_action 04:27:08 INFO - Running main action method: run_tests 04:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:27:08 INFO - Python 2.7.3 04:27:08 INFO - Return code: 0 04:27:08 INFO - grabbing minidump binary from tooltool 04:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:08 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 0x2a580b0>, '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 0x2a58fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a59440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:27:08 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:27:08 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:27:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:27:08 INFO - Return code: 0 04:27:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:27:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:27:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:27:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:27:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:27:09 INFO - Return code: 0 04:27:09 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] in /builds/slave/test/build 04:27:09 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost 04:27:09 INFO - Using env: {'DISPLAY': ':0', 04:27:09 INFO - 'HOME': '/home/cltbld', 04:27:09 INFO - 'LANG': 'en_US.UTF-8', 04:27:09 INFO - 'LANGUAGE': 'en_US:en', 04:27:09 INFO - 'LOGNAME': 'cltbld', 04:27:09 INFO - 'MAIL': '/var/mail/cltbld', 04:27:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:09 INFO - 'MOZ_NO_REMOTE': '1', 04:27:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:09 INFO - 'NO_EM_RESTART': '1', 04:27:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:09 INFO - 'PWD': '/builds/slave/test', 04:27:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:09 INFO - 'SHELL': '/bin/bash', 04:27:09 INFO - 'SHLVL': '1', 04:27:09 INFO - 'TERM': 'linux', 04:27:09 INFO - 'TMOUT': '86400', 04:27:09 INFO - 'USER': 'cltbld', 04:27:09 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242', 04:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:09 INFO - '_': '/tools/buildbot/bin/python'} 04:27:09 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] with output_timeout 3600 04:27:09 INFO - mozversion INFO | application_buildid: 20151204025717 04:27:09 INFO - mozversion INFO | application_changeset: a36cc9262f70b95c830ce1ff3bd415f346b46415 04:27:09 INFO - mozversion INFO | application_display_name: Nightly 04:27:09 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:27:09 INFO - mozversion INFO | application_name: Firefox 04:27:09 INFO - mozversion INFO | application_remotingname: firefox 04:27:09 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:27:09 INFO - mozversion INFO | application_vendor: Mozilla 04:27:09 INFO - mozversion INFO | application_version: 45.0a1 04:27:09 INFO - mozversion INFO | platform_buildid: 20151204025717 04:27:09 INFO - mozversion INFO | platform_changeset: a36cc9262f70b95c830ce1ff3bd415f346b46415 04:27:09 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:27:09 INFO - mozversion INFO | platform_version: 45.0a1 04:27:09 INFO - 2015-12-04 04:27:09,639 DEBUG : using testdate: 1449232029 04:27:09 INFO - 2015-12-04 04:27:09,639 DEBUG : actual date: 1449232029 04:27:09 INFO - 2015-12-04 04:27:09,726 INFO : starting webserver on 'localhost:37793' 04:27:09 INFO - 2015-12-04 04:27:09,727 INFO : Starting test suite talos-linux64-ix-020.e 04:27:09 INFO - 2015-12-04 04:27:09,727 INFO : Starting test dromaeo_css 04:27:09 INFO - 2015-12-04 04:27:09,727 DEBUG : operating with platform_type : linux_ 04:27:09 INFO - 2015-12-04 04:27:09,728 INFO : Initialising browser for dromaeo_css test... 04:27:09 INFO - 2015-12-04 04:27:09,740 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIVAy3W/profile http://localhost:37793/getInfo.html 04:27:14 INFO - 2015-12-04 04:27:14,870 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:27:14 INFO - 2015-12-04 04:27:14,870 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:27:14 INFO - 2015-12-04 04:27:14,870 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:27:14 INFO - 2015-12-04 04:27:14,870 DEBUG : BROWSER_OUTPUT: __metrics 04:27:14 INFO - 2015-12-04 04:27:14,987 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:27:15 INFO - 2015-12-04 04:27:15,921 INFO : Browser initialized. 04:27:15 INFO - 2015-12-04 04:27:15,922 INFO : Running cycle 1/1 for dromaeo_css test... 04:27:15 INFO - 2015-12-04 04:27:15,922 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIVAy3W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:27:28 INFO - 2015-12-04 04:27:28,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 142188544 04:27:28 INFO - 2015-12-04 04:27:28,025 DEBUG : BROWSER_OUTPUT: 04:28:17 INFO - 2015-12-04 04:28:17,669 DEBUG : BROWSER_OUTPUT: 1449232097668 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:30:29 INFO - 2015-12-04 04:30:29,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37793/tests/dromaeo/cssquery-ext.html) 04:30:30 INFO - 2015-12-04 04:30:30,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 146780160 04:30:30 INFO - 2015-12-04 04:30:30,023 DEBUG : BROWSER_OUTPUT: 04:33:32 INFO - 2015-12-04 04:33:32,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/dromaeo/cssquery-ext.html (next: http://localhost:37793/tests/dromaeo/cssquery-jquery.html) 04:33:32 INFO - 2015-12-04 04:33:32,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 144420864 04:33:32 INFO - 2015-12-04 04:33:32,607 DEBUG : BROWSER_OUTPUT: 04:36:34 INFO - 2015-12-04 04:36:34,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37793/tests/dromaeo/cssquery-mootools.html) 04:36:34 INFO - 2015-12-04 04:36:34,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 146518016 04:36:34 INFO - 2015-12-04 04:36:34,969 DEBUG : BROWSER_OUTPUT: 04:39:36 INFO - 2015-12-04 04:39:36,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37793/tests/dromaeo/cssquery-prototype.html) 04:39:37 INFO - 2015-12-04 04:39:37,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 144523264 04:39:37 INFO - 2015-12-04 04:39:37,348 DEBUG : BROWSER_OUTPUT: 04:42:39 INFO - 2015-12-04 04:42:39,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37793/tests/dromaeo/cssquery-yui.html) 04:42:40 INFO - 2015-12-04 04:42:40,507 DEBUG : BROWSER_OUTPUT: RSS: Main: 144715776 04:42:40 INFO - 2015-12-04 04:42:40,508 DEBUG : BROWSER_OUTPUT: 04:45:42 INFO - 2015-12-04 04:45:42,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/dromaeo/cssquery-yui.html (next: http://localhost:37793/tests/dromaeo/cssquery-dojo.html) 04:45:43 INFO - 2015-12-04 04:45:43,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 147070976 04:45:43 INFO - 2015-12-04 04:45:43,098 DEBUG : BROWSER_OUTPUT: 04:45:43 INFO - 2015-12-04 04:45:43,100 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:45:43 INFO - 2015-12-04 04:45:43,100 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:45:43 INFO - 2015-12-04 04:45:43,100 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:45:43 INFO - 2015-12-04 04:45:43,100 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:45:43 INFO - 2015-12-04 04:45:43,104 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2631.947361052779;2666.6400035995134;2678.183154137987;2718.850463224523;2724.087430710712;4413.293872980324;4673.789679464419;4674.859754207375;4704.3413922050895;4720.976395118028;4563.7489938053395;4574.290984897338;4588.151192029477;4680.906381872361;4695.436547614283;4281.743095414277;4355.54266801986;4396;4409.4708634963845;4452.287633978564;4330.523642399349;4350.564943505656;4359.673024523157;4457.175422546839;4471.552844715518;4138.275801734714;4210.536840947493;4232.343986682069;4337.436133302682;4347.500037495681;4353.477582690098;4360;4364.672649551297;4373.497047839475;4383.649308055348;4344.608985191317;4344.847930322455;4364.127174565099;4364.886953826785;4406.339049142654;4308;4421.491528474235;4530.728156310632;4679.110968915895;4682.836100736458;4907.9263811042865;4997.525235102659;5000.924986125211;5021.221710634857;5069.923951140736;5037.042961837239;5042.621803364762;5046.268291097807;5050.7222102784335;5096.643234973553;4412.029353542215;4514.751688657156;4590.449146102423;4675.29870519418;4698.365720627671;5191.8182863599595;5194.454582268807;5205.531502164823;5229.267902493654;5256.632035757537;4733.148033354029;4964.8510544682995;4984.800607975641;4989.525995030466;5005.599552035828;4896.824762057081;4906.975465122651;4953.777080031407;4973.378327709036;5019.723915184627;4962.007598480246;4984.127777638899;4989.750512474362;4998.350214472095;5032;4732.195526760459;4801.903961920742;4939.407271127416;4946.183879659816;4992.475790041994;4072.1855628874346;4085.20338533989;4090.9590904091174;4106.404571337199;4151.294279972412;3624.184558474375;3639.890803275853;3643.890683279506;3678.5401824771902;3680.3191409588776;4044.130511939888;4142.730722503088;4180.122174343422;4292.18448494785;4313.6980411370905;4988.90022199554;5016.172331565251;5030.320906677552;5055.646104772704;5064.518870707277;4310.612044915973;4323.740575565414;4327.437433133672;4344.674149438804;4371.322445021026;4184.330507118846;4253.48958125027;4278.229918614679;4378.934315985262;4447.332900064951;4764.213904705754;4802.471728109836;4809.326694262806;4814.277858321279;4837.129316723023;5064.898702026013;5078.390593128848;5093.261477085876;5102.642815002914;5138.640295179451;4551.817927282872;4613.700109492872;4624.28323609841;4671.76641167947;4768.61851051922;4936.950630493793;4943.480934501826;4955.242966751958;4970.900581988268;4983.800647974185;5037.874053148701;5041;5048.596112310933;5056.292119103255;5108.514691104339;4613.630909527163;4735.715857048588;4742.525747425368;4806.351142595845;4846.418429788448;4817.5182481752945;4877.90244195107;4881.755912204305;4882.584980276574;4925.482824303396;4578.748168850745;4793.304970779287;4804.35141255926;4806;4850.951490485191;4791.952080479151;4810.42274927011;4854.80580776765;4857.417109946829;4900.8774780630765;4739.691920025325;4810.759462026955;4810.855674329776;4828.396450443694;4884.998575291986 04:45:43 INFO - 2015-12-04 04:45:43,104 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.1352097488406;559.3064599896128;565.9462351076648;586.0769288370815;621.679834885034;36900;37362.43956340657;37739.622603773954;37768;37850.62149378505;37313.626863731355;37814.4327835082;37925.81037094811;38009.04977375567;38020.23959520808;7532.359749421292;7726.497777644463;7730.574818384986;7732.884006739903;7736;7588.734394296201;7589.962050189742;7663.846723065535;7685.5388676679295;7705.383569314441;7529.887051694229;7573.091229052521;7610.35311998478;7615.5811430371305;7629.961850190742;7767.766966990971;7800.687972481122;7822.882656760153;7842.960785196095;7851.45039847211;7744.922550774477;7765.495242809199;7782.883256751154;7817.530948143073;7821.296083352526;35216.29567408663;35795.64204357949;35805.82097089498;35873.46189807155;35929.82035089834;2759.1998320487237;2870.2680816391894;3005.323802144522;3440.673136052071;3583.6953858922025;28142.15573532797;28410.147695569165;28436.28909277264;28728.42543149146;28765.56851647206;3279.360524697685;3482;3524.8766293179874;3535.7878527288444;3562.679358857715;216333;216459;216693;217273;217550;51724.482755171965;53296.20055699167;55390.44609553853;55560.44439555633;56061;65526;66281;66866.66566667135;66897.66551167212;67089;12998.285094319714;13038.348082595832;13097.869021309856;13109.344532773513;13169.078164528582;9538.141567258841;9570.665026724031;9582.28132890036;9602.759931001781;9627;19245.467516787776;19545.90227048884;19618.411447656592;19626.313079042164;19690.507737306394;7514.323710866049;7621.771346859603;7705.961470192613;7751.34113600339;7751.806204844811;831.3100126894662;892.3307519360479;894.4409743910056;917.2249449215402;934.3506263147184;25002.624960625606;25906;25915.611265831027;26028.86985565098;26180.476390472464;947.5499137909438;970.2819913264275;1015.791762688647;1048.3395460859763;1049.6168898352046;13424.597262082154;13437.193768373929;13452;13583;13721.519746809014;330209.3489532537;332299;332781;334433;334607;48091.519084809406;48823.267650984555;49032.75483622559;49091.509084909405;49094.75452622714;1201.549418967887;1208.788462019143;1212.1636071111081;1214.089432925306;1223.3516236394726;25014.37464063413;25713.742862571136;26063.73936260613;26249.212523624323;26298.60552091682;37652.05869853166;38196;38214.80892595519;38268;38318.23363532769;248104;249380;251301;251541;253505;29832;35054.824725876206;38910.6108938907;41758.58241417547;43266.13467730565;39602;39963;40446.1910761789;40770.38844417396;41076;33308.666913330555;33671.3265734679;34393.65606343905;34616.48075278822;35105.29789404147;36721.63278367289;38044.61955380411;38294.80852595719;38340.55049524707;38852.222955540165;33947.32105357928;34419.483707744905;34422.48366274458;34589.48115778215;34605;29544.409111817215;30466;31010.224744381572;31031.84484077565;31076;24143.56279873536;24427;24437.38906527351;24784.884680189076;24810.37974050591 04:45:43 INFO - 2015-12-04 04:45:43,107 DEBUG : BROWSER_OUTPUT: |2;jquery.html;300.88115194498187;307.88300445830583;313.3842000469078;319.25135557118557;325.05247204399177;14643;15046.097234165944;15146.84853151468;15657.373705051812;16417.261223244954;9177.08229177082;9396.859047114282;11028.779424411507;13526.729465410686;13540.59378218655;4542.250528662767;4549.363089167519;4670.439547254335;4677.83627573035;4681.110588988098;4597.724136551801;4616.492185859553;4629.120467111238;4632.050429661911;4652.13935421948;3389.57630296213;3484.878029268976;4632.559906808848;4634.420697412824;5233.555147812441;5372.946270537283;5397.028534863723;5405.702686352249;5405.918911216335;5436.2661040759585;4697.600703940169;4806.927896081562;4814.638902082358;5172.793088276464;5214.97392513035;10592.523336449802;10985.01134897863;11262.267952583055;11352.94323528377;11401;1853.5458812590866;1886.5849513107094;1931.6812725900209;1938.8255057044792;2173.2067795254775;8988.77528061797;9301.255899528021;11610.942551110133;11938.701532461671;12399.318037507934;1694.9152542372833;1711.4352263752933;1737.9826201737947;1775.3874913154941;1781.234069350179;54899;56216.71891640557;56654.15018774722;56812.715936420056;57920;9390.436573805593;9418.10527999839;9477.90522094784;9521.619135234652;9532.618695252113;11826.467808948619;11836.644900652995;11861.703457413634;11881.88118118825;11928.880711192951;6481.384268494486;6644.83387915306;6706.094677218513;6715.1941766988275;6808.080909077211;6201.162843016225;6228.532860035515;6258.937410625836;6280.026595877646;6288.182536270256;3926.391409331558;3959.089409435788;3973;3974.940375894364;3994.1013272014147;1570.7800907872906;1588.769628403898;1710.42700695266;1715.082430899463;1737.409280844519;357.9266250418658;360.3279883018205;393.75587135975877;840.4537050916831;894.3113802372137;9563.521823908777;15300.846991530165;15305.6990155838;15572.299246533934;15836.683266334609;859.7979474823411;903.2277402820494;904.4618452021037;947.1286416496839;984.468387070988;8988.280937524982;9197.81604367909;9313.301502387349;9382.202512786353;9629;306293;309280;315326;476669;481963;60945;62538.374616254165;63260.367396326365;65059.67470162713;65386.346136538974;408.7179845906315;412.9566395528426;416.1468988573473;416.83326669331905;417.39686153507887;9279.350445468752;9293.349465537347;9441.952790236004;9740.318177727491;10065.245106616887;32961.505577416836;34259.31481370309;35118.12204694903;35382.64617353897;35535.28929421449;40718.796406017784;40721;41473;42424.36363454613;43826.342604860314;8292.253697167043;8583.098774628825;8662.523561203941;8775;8813.691520796741;8321.791955201168;10438.582456701646;15482;15776.13231272291;15782.289796959394;11862.228955118235;13799.517016904761;13815.861841381458;14082.507112251433;14475.855241447873;12587.433565489391;12628.179168354027;12735.108542402313;12998.545050923172;13106.475740970636;13216.207027578375;13449.663758405726;13507.864921350661;13640.181589104686;13655.590332290047;8751.343649226206;8808.779780505538;8907.73276801697;8942.552872356486;8989.775255618662;8847.778805529913;9003.63985440575;12995.28525931083;13255.734885302047;13397.933010334886 04:45:43 INFO - 2015-12-04 04:45:43,107 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1478.438193486475;1656.6935117003354;1673.2303140555343;1708.8632909367243;1735.5487573230964;6108.3586223446455;6231.096491008801;6629.469642428606;7128.643567821614;7130.393916517096;6586.748517781618;6709.127813384265;6729.7644582439625;6748.122744043279;6752.459803215743;2041.9999999999964;2084.9791502084936;2095.2561840546614;2096.3186964236606;2096.8008039236247;2083.291680828518;2112.0284669052253;2123.5115923337644;2145;2155.181031208139;2015.0932080563805;2016.5059560407722;2032.7459067616549;2034.206659402834;2039.276056999766;2048.201201531404;2061.3815855243365;2070.9378718638463;2072.450800537851;2072.875627462357;2052.5381789097482;2086.9165233390645;2100.5168811173517;2107.525806693497;2113.778053304396;6986.860262794716;7035.542689725203;7067.89398159028;7080.468964827607;7093;4017.718759686823;4062.695297852673;4091.5908409158847;4092.7953602320063;4093.8362465501345;2759.1308737747745;2776.7917406194615;2798.6641603007565;2833.702461241581;2851.543752999531;907.9319051071196;1667.2164082881147;1668.57451349905;1710.4441056656635;1723.2331612432472;9110.908890911138;9293.860592091056;9295.11696388842;9304.72085837426;9313.720588382359;3739.775613463201;3765.604611515806;3818.2554401891366;3824.655780979725;3907.7264591478324;7693.192214817475;7696.884546731803;7699.153093159748;7707.961460192775;7733.651985660659;4066.268071747055;4073.918521629551;4087.305158123126;4124.443200167939;4129.2773764591075;3217.8069315840658;3298.1919429739387;3653.725970552219;3728.9440658390145;3731.570869350005;3193.1857376369344;3200.6639302873327;3220.710136087763;3277.8688852445634;3286.7699261051976;938.7324612485409;966.5650457294246;967.4098799732158;968.1431932739576;969.7866469376726;1073.3023534702506;1098.1434481104752;1131.298594871185;1149.7987852125846;1154.2901115813713;6559.114519539897;6638.900416493757;6668.7329407412435;6686.7993960181275;6716.630585317855;422.2294312879008;427.3884783189352;429.5682838747102;430.9396684464177;432.9437173167468;5266.1574148136115;5323.600729945192;5333.786648534093;5341.225522299244;5346.7861285548925;8075;8145.266925976691;8211.876821847676;8287.088420273765;8421.15788421153;8273.33813294935;8295.792605184919;8299.875501867476;8335.208155225244;8363.247307742333;6014.278286605548;6221.96889015552;6264.467520260829;6265.154204182377;6267.373262673696;6557.770478033246;6558.704858281484;6580.5722628029025;6603.075569420189;6610.173728283965;7228.421726261781;7263.382612477787;7356.852862942818;7369.226231245642;7385.335319821242;7445;7499.812504687208;7545;7602.923970760222;7606.581638009962;5344.144936810092;5428.511433970962;5945.821625351246;5958.493528050164;6023.548233882564;6596.80209593713;6701.463882889455;6727.260001399744;6740.595564266159;6755.459563234831;6211.9068213975925;6278.372162783685;6363.904541431974;6404.839879003062;6495.805125846232;6258.092576576462;6271.372862713874;6320.841978950563;6378.585391949508;6454.644994525158;6405.295417503978;6438.806835794933;6450.161479007699;6458.935410645833;6477.190351206099;5916.55625828056;5918.763249469973;5946.583739138218;5954.37479064692;5963.52291816645;5893.823185304448;5973.402659733992;5992.400759923973;5995.88008239824;5999.820005399845 04:45:43 INFO - 2015-12-04 04:45:43,107 DEBUG : BROWSER_OUTPUT: |4;prototype.html;278.729632256711;285.6900263214412;287.7151619896303;287.87477447310437;289.083604972238;5371.462853714626;5470.179473079035;5509.090999984997;5569.749361278742;5599.63602365846;5519.889602207963;5524.171374293858;5525.834224973247;5530;5532.225488431613;4225.04936389313;4225.176090662322;4238.321868501041;4250.319948808191;4252.8511502097435;4250.957490425102;4264.97867510662;4267.189234045537;4270.57294270572;4270.97864510677;4160.251154792151;4211.199872024321;4231.428757117796;4231.576842315759;4238.788060596973;4234.195502854448;4237.978810105945;4238.152369526077;4238.470191226097;4239.682023848209;3673.430618254175;3677.4922281864574;3679.411294192916;3686.612905644922;3689.501917241165;5301.973490132563;5304.761285742113;5331.306930099101;5353.437889021636;5356.812511562116;4565.497795242521;4844.467108618049;4862.659613827033;4863.8297659582095;4872.926906096412;5611.943880561183;5746.166805813175;5758.309002919635;5762.827115186551;5763.049096899007;3795.69634429245;3800.9809950950344;3802.4106263529197;3804.201117765245;3815.751976121571;6016.699165041774;6017.578769486137;6081.483073938721;6086.2087928569;6106.816795496098;3890.5216017913012;3948.486696729407;3957.2679054375035;3974.523057233093;3981.9402708959387;3995.780232087263;3998.2403343364667;4024.476818013698;4025.6376926076796;4028.858989935397;4667.229907065296;4671.976640116778;4686.484486706459;4695.9668872847915;4715.386999690087;5759.798407055733;5759.913601295984;5769.1634712967225;5780.913286300709;5791.333996590446;1399.7130588229388;1399.9580012599638;1400.250865786799;1400.4608225832924;1401.1523028567774;886.5301390263171;927.9072092790802;930.4417349590327;933.2627224492575;946.0775743650024;4971.552560269593;4982.427020892571;4984.451710311862;4989.55094041538;4995.275685025651;5948.10778383246;5952.166696662471;5955.404459554096;5963.970180149158;5981.581289309706;4983.327250821093;4989.376327959005;4990.8253211137435;4999.0501804657;4999.425066117443;3172.762042846796;3183.5383869338816;3231.579894613685;3252.6259480160084;3269.313444176702;5710.65736055838;5748.9425105748405;5754.856128596819;5755.194272801811;5759.049756790083;6206.286277078104;6250.843728906813;6267.2165979252595;6273.1844860167885;6275.497960163268;5612.818036696124;5689.9146512802345;5695.971520142372;5723.656580605177;5731.111677689964;6030.547708921761;6043.425874541911;6050.9394906050375;6079.756809727738;6087.908681369694;5895.734691938787;5905.645661260338;5912.645241285537;5921.61509501881;5941.970290148522;5661.150827375926;5664.85837854057;5689.061304884648;5713.114467257582;5718.342390625131;3796.5064541609413;3930.6265904739003;3954.822033008464;3960.3267444535077;3961.5246170459727;5986.790462333797;5995.2206213192;6012.789552365821;6021.849453763691;6025.578209525291;5795.536357091339;5799.82600521985;5800.39095894925;5809.506191973561;5812.476877080914;5667;5753.108268218432;5794.391588883106;5810.186573879576;5849.970750146222;5708.628939118944;5708.743106560131;5713.571482138939;5717.1138473535;5719.113537401709;5816.47651711348;5856.560757943086;5867.354590994902;5871.1486834409625;5881.7647294107755;5530.695811730394;5696.458836410535;5745.425457454221;5754.741036653277;5757.8560535986935 04:45:43 INFO - 2015-12-04 04:45:43,109 DEBUG : BROWSER_OUTPUT: |5;yui.html;762.9542227466352;767.9270469305415;774.0950719581334;777.5684495105214;786.7718361675114;11515.193936424454;11944.044476441886;11947.402629868515;11978.820317695241;12002.759944801099;11357.318560886331;11530.135239857023;11549.249298795572;11556.768864622703;11588.826167607493;627.5105417774121;636.5353292096772;794.1105961323326;804.493169303338;809.324214281076;789;794.0392125528118;797.5374282915894;798.0822054637156;802.2018091998441;848.7708318753932;853.731074711467;854.8589482735341;857.6355049104137;861.0786458489418;845.6194712379454;846.9068402475723;849.0405841399241;851.535912927456;853.6926706385697;629.8488362792942;630.124127462827;631.1038325577645;633.0219810392954;633.1610615933906;12400.81398779019;12447.190932589352;12475.438605262785;12558.183718058297;12570.30863302518;10833.891661083368;11378.544858205662;11504.137189710806;11658.941705291503;11727.296362218294;9162.541872906328;9178.908210917873;9209.217216536603;9327.160555550034;9428.292878034106;3216.6140063192565;3288.44096503595;3319.9004029879143;3321.8671253149846;3332.0836769888233;39983;40068;40100;40344.798276008434;40592;9014;9396.966333703287;9562.904370956341;9585.952070239604;9612.951935240419;16181.919090404472;16367;16430.75353869693;16439.83560164383;16454.177291135395;6107.816765497042;6196.783112591038;6241.313455519889;6308.211473565804;6520.217573891164;3431.3823511768123;3450.1202193440513;3573.874914377984;3595.532580764484;3716.7769933804057;2742.314421394651;2766.8754906028876;2768.169549135251;2771.4457108577963;2772.209920172741;501.34824727854374;508.7227461033672;510.64765311934644;512.7846304552022;526.4971951786035;561.7752898840497;587.2483221476517;615;624.3756243756244;643.9903401448983;7049.718011279491;7738.7678369649;7838;7869.645865936047;7912.762617121495;556.5213916032209;599.1671576508656;614.8616561273767;623.5635055461196;624.978125765596;3544.971958132113;3662.7436079474714;3670.3436235219365;3682.116292089933;3682.705383569308;52059.219111713355;52211.73894130505;52449.475505245224;52833.7358313206;52940.470595294326;47249.76375118171;47527;48096.7595162022;48231;48310.5168948306;42082.78958605188;43028.354574681405;43304.56695433131;43435;43736.12527749491;7037.577745335297;7042.190148132825;7102.4673149512955;7166.498345115792;7185.712571497082;32500;33651.66348336485;33714.3257134851;34262.31475370429;34866.30267394587;39911.40132897951;39984.600153998086;40509;41851.7907410461;42070.78964605158;10195.643152489627;10211.336263142872;10270.948645256725;10407.21945854079;10780.568777249136;10467.895321046997;10809.621663241749;10907.072898803373;10912.236143470198;10918.727031824268;10584.153267738408;10607.893921060691;10712.143028557852;10820;10829.837552436877;10359.274850760676;10534;10585.523651435858;10621.415822129547;10994.780104398027;10686.57253709874;10764.138868890626;10784.245102842726;10797.460126993776;10857.239993200401;8383.95808020956;8445;8477.74566762998;8668.739937801876;8772.122787721177;7737;8356.456830306011;8368.581570921551;8441.198086181803;8475.533845638549 04:45:43 INFO - 2015-12-04 04:45:43,109 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:45:43 INFO - 2015-12-04 04:45:43,109 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:45:43 INFO - 2015-12-04 04:45:43,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,336 04:45:43 INFO - 2015-12-04 04:45:43,109 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:45:43 INFO - 2015-12-04 04:45:43,109 DEBUG : BROWSER_OUTPUT: __startTimestamp1449233143099__endTimestamp 04:45:43 INFO - 2015-12-04 04:45:43,109 DEBUG : BROWSER_OUTPUT: 04:45:43 INFO - 2015-12-04 04:45:43,109 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:45:43 INFO - 2015-12-04 04:45:43,110 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:45:43 INFO - 2015-12-04 04:45:43,110 DEBUG : BROWSER_OUTPUT: 04:45:43 INFO - 2015-12-04 04:45:43,110 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4608.25 Median:4733.15 stddev:489.58 (10.3%) stddev-sans-first:465.89 04:45:43 INFO - 2015-12-04 04:45:43,110 DEBUG : BROWSER_OUTPUT: Values: 2631.9 2666.6 2678.2 2718.9 2724.1 4413.3 4673.8 4674.9 4704.3 4721.0 4563.7 4574.3 4588.2 4680.9 4695.4 4281.7 4355.5 4396.0 4409.5 4452.3 4330.5 4350.6 4359.7 4457.2 4471.6 4138.3 4210.5 4232.3 4337.4 4347.5 4353.5 4360.0 4364.7 4373.5 4383.6 4344.6 4344.8 4364.1 4364.9 4406.3 4308.0 4421.5 4530.7 4679.1 4682.8 4907.9 4997.5 5000.9 5021.2 5069.9 5037.0 5042.6 5046.3 5050.7 5096.6 4412.0 4514.8 4590.4 4675.3 4698.4 5191.8 5194.5 5205.5 5229.3 5256.6 4733.1 4964.9 4984.8 4989.5 5005.6 4896.8 4907.0 4953.8 4973.4 5019.7 4962.0 4984.1 4989.8 4998.4 5032.0 4732.2 4801.9 4939.4 4946.2 4992.5 4072.2 4085.2 4091.0 4106.4 4151.3 3624.2 3639.9 3643.9 3678.5 3680.3 4044.1 4142.7 4180.1 4292.2 4313.7 4988.9 5016.2 5030.3 5055.6 5064.5 4310.6 4323.7 4327.4 4344.7 4371.3 4184.3 4253.5 4278.2 4378.9 4447.3 4764.2 4802.5 4809.3 4814.3 4837.1 5064.9 5078.4 5093.3 5102.6 5138.6 4551.8 4613.7 4624.3 4671.8 4768.6 4937.0 4943.5 4955.2 4970.9 4983.8 5037.9 5041.0 5048.6 5056.3 5108.5 4613.6 4735.7 4742.5 4806.4 4846.4 4817.5 4877.9 4881.8 4882.6 4925.5 4578.7 4793.3 4804.4 4806.0 4851.0 4792.0 4810.4 4854.8 4857.4 4900.9 4739.7 4810.8 4810.9 4828.4 4885.0 04:45:43 INFO - 2015-12-04 04:45:43,110 DEBUG : BROWSER_OUTPUT: 04:45:43 INFO - 2015-12-04 04:45:43,110 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43105.87 Median:36810.82 stddev:71094.45 (193.1%) stddev-sans-first:71222.11 04:45:43 INFO - 2015-12-04 04:45:43,111 DEBUG : BROWSER_OUTPUT: Values: 556.1 559.3 565.9 586.1 621.7 36900.0 37362.4 37739.6 37768.0 37850.6 37313.6 37814.4 37925.8 38009.0 38020.2 7532.4 7726.5 7730.6 7732.9 7736.0 7588.7 7590.0 7663.8 7685.5 7705.4 7529.9 7573.1 7610.4 7615.6 7630.0 7767.8 7800.7 7822.9 7843.0 7851.5 7744.9 7765.5 7782.9 7817.5 7821.3 35216.3 35795.6 35805.8 35873.5 35929.8 2759.2 2870.3 3005.3 3440.7 3583.7 28142.2 28410.1 28436.3 28728.4 28765.6 3279.4 3482.0 3524.9 3535.8 3562.7 216333.0 216459.0 216693.0 217273.0 217550.0 51724.5 53296.2 55390.4 55560.4 56061.0 65526.0 66281.0 66866.7 66897.7 67089.0 12998.3 13038.3 13097.9 13109.3 13169.1 9538.1 9570.7 9582.3 9602.8 9627.0 19245.5 19545.9 19618.4 19626.3 19690.5 7514.3 7621.8 7706.0 7751.3 7751.8 831.3 892.3 894.4 917.2 934.4 25002.6 25906.0 25915.6 26028.9 26180.5 947.5 970.3 1015.8 1048.3 1049.6 13424.6 13437.2 13452.0 13583.0 13721.5 330209.3 332299.0 332781.0 334433.0 334607.0 48091.5 48823.3 49032.8 49091.5 49094.8 1201.5 1208.8 1212.2 1214.1 1223.4 25014.4 25713.7 26063.7 26249.2 26298.6 37652.1 38196.0 38214.8 38268.0 38318.2 248104.0 249380.0 251301.0 251541.0 253505.0 29832.0 35054.8 38910.6 41758.6 43266.1 39602.0 39963.0 40446.2 40770.4 41076.0 33308.7 33671.3 34393.7 34616.5 35105.3 36721.6 38044.6 38294.8 38340.6 38852.2 33947.3 34419.5 34422.5 34589.5 34605.0 29544.4 30466.0 31010.2 31031.8 31076.0 24143.6 24427.0 24437.4 24784.9 24810.4 04:45:43 INFO - 2015-12-04 04:45:43,112 DEBUG : BROWSER_OUTPUT: 04:45:43 INFO - 2015-12-04 04:45:43,112 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22442.85 Median:20944.57 stddev:63462.47 (303.0%) stddev-sans-first:63618.72 04:45:43 INFO - 2015-12-04 04:45:43,112 DEBUG : BROWSER_OUTPUT: Values: 300.9 307.9 313.4 319.3 325.1 14643.0 15046.1 15146.8 15657.4 16417.3 9177.1 9396.9 11028.8 13526.7 13540.6 4542.3 4549.4 4670.4 4677.8 4681.1 4597.7 4616.5 4629.1 4632.1 4652.1 3389.6 3484.9 4632.6 4634.4 5233.6 5372.9 5397.0 5405.7 5405.9 5436.3 4697.6 4806.9 4814.6 5172.8 5215.0 10592.5 10985.0 11262.3 11352.9 11401.0 1853.5 1886.6 1931.7 1938.8 2173.2 8988.8 9301.3 11610.9 11938.7 12399.3 1694.9 1711.4 1738.0 1775.4 1781.2 54899.0 56216.7 56654.2 56812.7 57920.0 9390.4 9418.1 9477.9 9521.6 9532.6 11826.5 11836.6 11861.7 11881.9 11928.9 6481.4 6644.8 6706.1 6715.2 6808.1 6201.2 6228.5 6258.9 6280.0 6288.2 3926.4 3959.1 3973.0 3974.9 3994.1 1570.8 1588.8 1710.4 1715.1 1737.4 357.9 360.3 393.8 840.5 894.3 9563.5 15300.8 15305.7 15572.3 15836.7 859.8 903.2 904.5 947.1 984.5 8988.3 9197.8 9313.3 9382.2 9629.0 306293.0 309280.0 315326.0 476669.0 481963.0 60945.0 62538.4 63260.4 65059.7 65386.3 408.7 413.0 416.1 416.8 417.4 9279.4 9293.3 9442.0 9740.3 10065.2 32961.5 34259.3 35118.1 35382.6 35535.3 40718.8 40721.0 41473.0 42424.4 43826.3 8292.3 8583.1 8662.5 8775.0 8813.7 8321.8 10438.6 15482.0 15776.1 15782.3 11862.2 13799.5 13815.9 14082.5 14475.9 12587.4 12628.2 12735.1 12998.5 13106.5 13216.2 13449.7 13507.9 13640.2 13655.6 8751.3 8808.8 8907.7 8942.6 8989.8 8847.8 9003.6 12995.3 13255.7 13397.9 04:45:43 INFO - 2015-12-04 04:45:43,112 DEBUG : BROWSER_OUTPUT: 04:45:43 INFO - 2015-12-04 04:45:43,112 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4851.80 Median:5994.14 stddev:2464.36 (41.1%) stddev-sans-first:2458.23 04:45:43 INFO - 2015-12-04 04:45:43,112 DEBUG : BROWSER_OUTPUT: Values: 1478.4 1656.7 1673.2 1708.9 1735.5 6108.4 6231.1 6629.5 7128.6 7130.4 6586.7 6709.1 6729.8 6748.1 6752.5 2042.0 2085.0 2095.3 2096.3 2096.8 2083.3 2112.0 2123.5 2145.0 2155.2 2015.1 2016.5 2032.7 2034.2 2039.3 2048.2 2061.4 2070.9 2072.5 2072.9 2052.5 2086.9 2100.5 2107.5 2113.8 6986.9 7035.5 7067.9 7080.5 7093.0 4017.7 4062.7 4091.6 4092.8 4093.8 2759.1 2776.8 2798.7 2833.7 2851.5 907.9 1667.2 1668.6 1710.4 1723.2 9110.9 9293.9 9295.1 9304.7 9313.7 3739.8 3765.6 3818.3 3824.7 3907.7 7693.2 7696.9 7699.2 7708.0 7733.7 4066.3 4073.9 4087.3 4124.4 4129.3 3217.8 3298.2 3653.7 3728.9 3731.6 3193.2 3200.7 3220.7 3277.9 3286.8 938.7 966.6 967.4 968.1 969.8 1073.3 1098.1 1131.3 1149.8 1154.3 6559.1 6638.9 6668.7 6686.8 6716.6 422.2 427.4 429.6 430.9 432.9 5266.2 5323.6 5333.8 5341.2 5346.8 8075.0 8145.3 8211.9 8287.1 8421.2 8273.3 8295.8 8299.9 8335.2 8363.2 6014.3 6222.0 6264.5 6265.2 6267.4 6557.8 6558.7 6580.6 6603.1 6610.2 7228.4 7263.4 7356.9 7369.2 7385.3 7445.0 7499.8 7545.0 7602.9 7606.6 5344.1 5428.5 5945.8 5958.5 6023.5 6596.8 6701.5 6727.3 6740.6 6755.5 6211.9 6278.4 6363.9 6404.8 6495.8 6258.1 6271.4 6320.8 6378.6 6454.6 6405.3 6438.8 6450.2 6458.9 6477.2 5916.6 5918.8 5946.6 5954.4 5963.5 5893.8 5973.4 5992.4 5995.9 5999.8 04:45:43 INFO - 2015-12-04 04:45:43,112 DEBUG : BROWSER_OUTPUT: 04:45:43 INFO - 2015-12-04 04:45:43,112 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4769.98 Median:5527.92 stddev:1445.57 (26.2%) stddev-sans-first:1409.78 04:45:43 INFO - 2015-12-04 04:45:43,113 DEBUG : BROWSER_OUTPUT: Values: 278.7 285.7 287.7 287.9 289.1 5371.5 5470.2 5509.1 5569.7 5599.6 5519.9 5524.2 5525.8 5530.0 5532.2 4225.0 4225.2 4238.3 4250.3 4252.9 4251.0 4265.0 4267.2 4270.6 4271.0 4160.3 4211.2 4231.4 4231.6 4238.8 4234.2 4238.0 4238.2 4238.5 4239.7 3673.4 3677.5 3679.4 3686.6 3689.5 5302.0 5304.8 5331.3 5353.4 5356.8 4565.5 4844.5 4862.7 4863.8 4872.9 5611.9 5746.2 5758.3 5762.8 5763.0 3795.7 3801.0 3802.4 3804.2 3815.8 6016.7 6017.6 6081.5 6086.2 6106.8 3890.5 3948.5 3957.3 3974.5 3981.9 3995.8 3998.2 4024.5 4025.6 4028.9 4667.2 4672.0 4686.5 4696.0 4715.4 5759.8 5759.9 5769.2 5780.9 5791.3 1399.7 1400.0 1400.3 1400.5 1401.2 886.5 927.9 930.4 933.3 946.1 4971.6 4982.4 4984.5 4989.6 4995.3 5948.1 5952.2 5955.4 5964.0 5981.6 4983.3 4989.4 4990.8 4999.1 4999.4 3172.8 3183.5 3231.6 3252.6 3269.3 5710.7 5748.9 5754.9 5755.2 5759.0 6206.3 6250.8 6267.2 6273.2 6275.5 5612.8 5689.9 5696.0 5723.7 5731.1 6030.5 6043.4 6050.9 6079.8 6087.9 5895.7 5905.6 5912.6 5921.6 5942.0 5661.2 5664.9 5689.1 5713.1 5718.3 3796.5 3930.6 3954.8 3960.3 3961.5 5986.8 5995.2 6012.8 6021.8 6025.6 5795.5 5799.8 5800.4 5809.5 5812.5 5667.0 5753.1 5794.4 5810.2 5850.0 5708.6 5708.7 5713.6 5717.1 5719.1 5816.5 5856.6 5867.4 5871.1 5881.8 5530.7 5696.5 5745.4 5754.7 5757.9 04:45:43 INFO - 2015-12-04 04:45:43,113 DEBUG : BROWSER_OUTPUT: 04:45:43 INFO - 2015-12-04 04:45:43,114 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12543.18 Median:47388.38 stddev:14557.90 (30.7%) stddev-sans-first:14571.86 04:45:43 INFO - 2015-12-04 04:45:43,114 DEBUG : BROWSER_OUTPUT: Values: 763.0 767.9 774.1 777.6 786.8 11515.2 11944.0 11947.4 11978.8 12002.8 11357.3 11530.1 11549.2 11556.8 11588.8 627.5 636.5 794.1 804.5 809.3 789.0 794.0 797.5 798.1 802.2 848.8 853.7 854.9 857.6 861.1 845.6 846.9 849.0 851.5 853.7 629.8 630.1 631.1 633.0 633.2 12400.8 12447.2 12475.4 12558.2 12570.3 10833.9 11378.5 11504.1 11658.9 11727.3 9162.5 9178.9 9209.2 9327.2 9428.3 3216.6 3288.4 3319.9 3321.9 3332.1 39983.0 40068.0 40100.0 40344.8 40592.0 9014.0 9397.0 9562.9 9586.0 9613.0 16181.9 16367.0 16430.8 16439.8 16454.2 6107.8 6196.8 6241.3 6308.2 6520.2 3431.4 3450.1 3573.9 3595.5 3716.8 2742.3 2766.9 2768.2 2771.4 2772.2 501.3 508.7 510.6 512.8 526.5 561.8 587.2 615.0 624.4 644.0 7049.7 7738.8 7838.0 7869.6 7912.8 556.5 599.2 614.9 623.6 625.0 3545.0 3662.7 3670.3 3682.1 3682.7 52059.2 52211.7 52449.5 52833.7 52940.5 47249.8 47527.0 48096.8 48231.0 48310.5 42082.8 43028.4 43304.6 43435.0 43736.1 7037.6 7042.2 7102.5 7166.5 7185.7 32500.0 33651.7 33714.3 34262.3 34866.3 39911.4 39984.6 40509.0 41851.8 42070.8 10195.6 10211.3 10270.9 10407.2 10780.6 10467.9 10809.6 10907.1 10912.2 10918.7 10584.2 10607.9 10712.1 10820.0 10829.8 10359.3 10534.0 10585.5 10621.4 10994.8 10686.6 10764.1 10784.2 10797.5 10857.2 8384.0 8445.0 8477.7 8668.7 8772.1 7737.0 8356.5 8368.6 8441.2 8475.5 04:45:43 INFO - 2015-12-04 04:45:43,114 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:45:43 INFO - 2015-12-04 04:45:43,114 DEBUG : BROWSER_OUTPUT: 04:45:43 INFO - 2015-12-04 04:45:43,933 INFO : Browser exited with error code: 0 04:45:43 INFO - 2015-12-04 04:45:43,952 INFO : Completed test dromaeo_css (00:18:34) 04:45:43 INFO - 2015-12-04 04:45:43,952 INFO : Starting test kraken 04:45:43 INFO - 2015-12-04 04:45:43,952 DEBUG : operating with platform_type : linux_ 04:45:43 INFO - 2015-12-04 04:45:43,952 INFO : Initialising browser for kraken test... 04:45:43 INFO - 2015-12-04 04:45:43,958 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRmN8kJ/profile http://localhost:37793/getInfo.html 04:45:49 INFO - 2015-12-04 04:45:49,256 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:45:49 INFO - 2015-12-04 04:45:49,256 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:45:49 INFO - 2015-12-04 04:45:49,257 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:45:49 INFO - 2015-12-04 04:45:49,257 DEBUG : BROWSER_OUTPUT: __metrics 04:45:49 INFO - 2015-12-04 04:45:49,405 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:45:50 INFO - 2015-12-04 04:45:50,329 INFO : Browser initialized. 04:45:50 INFO - 2015-12-04 04:45:50,330 INFO : Running cycle 1/1 for kraken test... 04:45:50 INFO - 2015-12-04 04:45:50,330 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRmN8kJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:46:02 INFO - 2015-12-04 04:46:02,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 143675392 04:46:02 INFO - 2015-12-04 04:46:02,332 DEBUG : BROWSER_OUTPUT: 04:46:04 INFO - 2015-12-04 04:46:04,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37793/tests/kraken/driver.html?testName=audio-beat-detection) 04:46:05 INFO - 2015-12-04 04:46:05,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 144371712 04:46:05 INFO - 2015-12-04 04:46:05,535 DEBUG : BROWSER_OUTPUT: 04:46:08 INFO - 2015-12-04 04:46:08,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37793/tests/kraken/driver.html?testName=audio-dft) 04:46:08 INFO - 2015-12-04 04:46:08,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 144990208 04:46:08 INFO - 2015-12-04 04:46:08,921 DEBUG : BROWSER_OUTPUT: 04:46:11 INFO - 2015-12-04 04:46:11,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37793/tests/kraken/driver.html?testName=audio-fft) 04:46:12 INFO - 2015-12-04 04:46:12,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 138817536 04:46:12 INFO - 2015-12-04 04:46:12,440 DEBUG : BROWSER_OUTPUT: 04:46:14 INFO - 2015-12-04 04:46:14,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37793/tests/kraken/driver.html?testName=audio-oscillator) 04:46:15 INFO - 2015-12-04 04:46:15,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 139739136 04:46:15 INFO - 2015-12-04 04:46:15,134 DEBUG : BROWSER_OUTPUT: 04:46:17 INFO - 2015-12-04 04:46:17,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37793/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:46:17 INFO - 2015-12-04 04:46:17,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 141385728 04:46:17 INFO - 2015-12-04 04:46:17,970 DEBUG : BROWSER_OUTPUT: 04:46:21 INFO - 2015-12-04 04:46:21,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37793/tests/kraken/driver.html?testName=imaging-darkroom) 04:46:21 INFO - 2015-12-04 04:46:21,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 141164544 04:46:21 INFO - 2015-12-04 04:46:21,626 DEBUG : BROWSER_OUTPUT: 04:46:25 INFO - 2015-12-04 04:46:25,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37793/tests/kraken/driver.html?testName=imaging-desaturate) 04:46:25 INFO - 2015-12-04 04:46:25,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 139010048 04:46:25 INFO - 2015-12-04 04:46:25,701 DEBUG : BROWSER_OUTPUT: 04:46:28 INFO - 2015-12-04 04:46:28,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37793/tests/kraken/driver.html?testName=json-parse-financial) 04:46:29 INFO - 2015-12-04 04:46:29,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 139436032 04:46:29 INFO - 2015-12-04 04:46:29,186 DEBUG : BROWSER_OUTPUT: 04:46:30 INFO - 2015-12-04 04:46:30,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37793/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:46:31 INFO - 2015-12-04 04:46:31,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 141041664 04:46:31 INFO - 2015-12-04 04:46:31,551 DEBUG : BROWSER_OUTPUT: 04:46:33 INFO - 2015-12-04 04:46:33,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37793/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:46:34 INFO - 2015-12-04 04:46:34,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 140771328 04:46:34 INFO - 2015-12-04 04:46:34,052 DEBUG : BROWSER_OUTPUT: 04:46:36 INFO - 2015-12-04 04:46:36,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37793/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:46:36 INFO - 2015-12-04 04:46:36,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 141086720 04:46:36 INFO - 2015-12-04 04:46:36,819 DEBUG : BROWSER_OUTPUT: 04:46:39 INFO - 2015-12-04 04:46:39,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:46:39 INFO - 2015-12-04 04:46:39,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 141504512 04:46:39 INFO - 2015-12-04 04:46:39,990 DEBUG : BROWSER_OUTPUT: 04:46:42 INFO - 2015-12-04 04:46:42,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:46:43 INFO - 2015-12-04 04:46:43,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 140599296 04:46:43 INFO - 2015-12-04 04:46:43,176 DEBUG : BROWSER_OUTPUT: 04:46:44 INFO - 2015-12-04 04:46:44,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37793/tests/kraken/driver.html?testName=ai-astar) 04:46:45 INFO - 2015-12-04 04:46:45,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 141426688 04:46:45 INFO - 2015-12-04 04:46:45,196 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,197 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:46:45 INFO - 2015-12-04 04:46:45,198 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:46:45 INFO - 2015-12-04 04:46:45,198 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:46:45 INFO - 2015-12-04 04:46:45,198 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:46:45 INFO - 2015-12-04 04:46:45,198 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;107;113;113;113;124;114;112;113;114 04:46:45 INFO - 2015-12-04 04:46:45,198 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;129;158;172;132;168;151;130;175;133 04:46:45 INFO - 2015-12-04 04:46:45,198 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;164;162;162;163;178;166;162;164;164 04:46:45 INFO - 2015-12-04 04:46:45,198 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;76;73;79;138;71;80;73;72;90 04:46:45 INFO - 2015-12-04 04:46:45,199 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;129;95;95;94;131;94;95;136 04:46:45 INFO - 2015-12-04 04:46:45,199 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;111;118;111;109;110;110;110 04:46:45 INFO - 2015-12-04 04:46:45,199 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;147;148;148;146;148;148;148 04:46:45 INFO - 2015-12-04 04:46:45,199 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;96;97;96;96 04:46:45 INFO - 2015-12-04 04:46:45,199 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;74;72;72;73;75;74;82;70;70 04:46:45 INFO - 2015-12-04 04:46:45,199 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;71;67;71;68;68;68;69;68;69 04:46:45 INFO - 2015-12-04 04:46:45,199 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;93;85;86;86;85;86;87;88;87 04:46:45 INFO - 2015-12-04 04:46:45,199 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;137;129;126;126;123;126;119;121;122 04:46:45 INFO - 2015-12-04 04:46:45,200 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;148;147;151;147;139;145;148;148;136 04:46:45 INFO - 2015-12-04 04:46:45,200 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;70;69;70;70;69;69;68;71 04:46:45 INFO - 2015-12-04 04:46:45,200 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:46:45 INFO - 2015-12-04 04:46:45,200 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:46:45 INFO - 2015-12-04 04:46:45,200 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,807 04:46:45 INFO - 2015-12-04 04:46:45,200 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:46:45 INFO - 2015-12-04 04:46:45,200 DEBUG : BROWSER_OUTPUT: __startTimestamp1449233205196__endTimestamp 04:46:45 INFO - 2015-12-04 04:46:45,201 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,208 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:46:45 INFO - 2015-12-04 04:46:45,208 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:46:45 INFO - 2015-12-04 04:46:45,208 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,208 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.70 Median:113.50 stddev:4.16 (3.7%) stddev-sans-first:4.42 04:46:45 INFO - 2015-12-04 04:46:45,208 DEBUG : BROWSER_OUTPUT: Values: 114.0 107.0 113.0 113.0 113.0 124.0 114.0 112.0 113.0 114.0 04:46:45 INFO - 2015-12-04 04:46:45,208 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,208 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.80 Median:159.00 stddev:18.40 (11.6%) stddev-sans-first:19.21 04:46:45 INFO - 2015-12-04 04:46:45,208 DEBUG : BROWSER_OUTPUT: Values: 160.0 129.0 158.0 172.0 132.0 168.0 151.0 130.0 175.0 133.0 04:46:45 INFO - 2015-12-04 04:46:45,209 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,209 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:4.76 (2.9%) stddev-sans-first:5.05 04:46:45 INFO - 2015-12-04 04:46:45,209 DEBUG : BROWSER_OUTPUT: Values: 165.0 164.0 162.0 162.0 163.0 178.0 166.0 162.0 164.0 164.0 04:46:45 INFO - 2015-12-04 04:46:45,209 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,209 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:20.26 (27.0%) stddev-sans-first:21.24 04:46:45 INFO - 2015-12-04 04:46:45,209 DEBUG : BROWSER_OUTPUT: Values: 74.0 76.0 73.0 79.0 138.0 71.0 80.0 73.0 72.0 90.0 04:46:45 INFO - 2015-12-04 04:46:45,209 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,209 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:94.00 stddev:18.31 (19.5%) stddev-sans-first:18.93 04:46:45 INFO - 2015-12-04 04:46:45,209 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 129.0 95.0 95.0 94.0 131.0 94.0 95.0 136.0 04:46:45 INFO - 2015-12-04 04:46:45,209 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,210 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.80 Median:110.00 stddev:2.62 (2.4%) stddev-sans-first:2.76 04:46:45 INFO - 2015-12-04 04:46:45,210 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 111.0 118.0 111.0 109.0 110.0 110.0 110.0 04:46:45 INFO - 2015-12-04 04:46:45,210 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,210 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:46:45 INFO - 2015-12-04 04:46:45,210 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 147.0 148.0 148.0 146.0 148.0 148.0 148.0 04:46:45 INFO - 2015-12-04 04:46:45,210 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,210 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:46:45 INFO - 2015-12-04 04:46:45,210 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 04:46:45 INFO - 2015-12-04 04:46:45,211 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,211 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.50 Median:73.50 stddev:3.41 (4.6%) stddev-sans-first:3.61 04:46:45 INFO - 2015-12-04 04:46:45,211 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 72.0 72.0 73.0 75.0 74.0 82.0 70.0 70.0 04:46:45 INFO - 2015-12-04 04:46:45,211 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,211 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.50 stddev:1.34 (2.0%) stddev-sans-first:1.39 04:46:45 INFO - 2015-12-04 04:46:45,211 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 67.0 71.0 68.0 68.0 68.0 69.0 68.0 69.0 04:46:45 INFO - 2015-12-04 04:46:45,211 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,212 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.00 stddev:2.80 (3.2%) stddev-sans-first:2.45 04:46:45 INFO - 2015-12-04 04:46:45,212 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 85.0 86.0 86.0 85.0 86.0 87.0 88.0 87.0 04:46:45 INFO - 2015-12-04 04:46:45,212 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,212 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:126.00 stddev:5.07 (4.0%) stddev-sans-first:5.32 04:46:45 INFO - 2015-12-04 04:46:45,212 DEBUG : BROWSER_OUTPUT: Values: 123.0 137.0 129.0 126.0 126.0 123.0 126.0 119.0 121.0 122.0 04:46:45 INFO - 2015-12-04 04:46:45,212 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,212 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:147.50 stddev:5.27 (3.6%) stddev-sans-first:4.82 04:46:45 INFO - 2015-12-04 04:46:45,212 DEBUG : BROWSER_OUTPUT: Values: 137.0 148.0 147.0 151.0 147.0 139.0 145.0 148.0 148.0 136.0 04:46:45 INFO - 2015-12-04 04:46:45,213 DEBUG : BROWSER_OUTPUT: 04:46:45 INFO - 2015-12-04 04:46:45,213 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:0.95 (1.4%) stddev-sans-first:0.88 04:46:45 INFO - 2015-12-04 04:46:45,213 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 69.0 70.0 70.0 69.0 69.0 68.0 71.0 04:46:45 INFO - 2015-12-04 04:46:45,213 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:46:45 INFO - 2015-12-04 04:46:45,213 DEBUG : BROWSER_OUTPUT: 04:46:46 INFO - 2015-12-04 04:46:46,117 INFO : Browser exited with error code: 0 04:46:46 INFO - 2015-12-04 04:46:46,168 INFO : Completed test kraken (00:01:02) 04:46:46 INFO - 2015-12-04 04:46:46,168 INFO : Starting test v8_7 04:46:46 INFO - 2015-12-04 04:46:46,168 DEBUG : operating with platform_type : linux_ 04:46:46 INFO - 2015-12-04 04:46:46,168 INFO : Initialising browser for v8_7 test... 04:46:46 INFO - 2015-12-04 04:46:46,174 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgY1BJq/profile http://localhost:37793/getInfo.html 04:46:51 INFO - 2015-12-04 04:46:51,564 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:46:51 INFO - 2015-12-04 04:46:51,564 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:46:51 INFO - 2015-12-04 04:46:51,564 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:46:51 INFO - 2015-12-04 04:46:51,564 DEBUG : BROWSER_OUTPUT: __metrics 04:46:51 INFO - 2015-12-04 04:46:51,707 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:46:52 INFO - 2015-12-04 04:46:52,681 INFO : Browser initialized. 04:46:52 INFO - 2015-12-04 04:46:52,682 INFO : Running cycle 1/1 for v8_7 test... 04:46:52 INFO - 2015-12-04 04:46:52,682 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgY1BJq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:47:04 INFO - 2015-12-04 04:47:04,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 143208448 04:47:04 INFO - 2015-12-04 04:47:04,745 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37793/tests/v8_7/run.html (next: http://localhost:37793/tests/v8_7/run.html) 04:47:26 INFO - 2015-12-04 04:47:26,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 136978432 04:47:26 INFO - 2015-12-04 04:47:26,392 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,392 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:47:26 INFO - 2015-12-04 04:47:26,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:47:26 INFO - 2015-12-04 04:47:26,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:47:26 INFO - 2015-12-04 04:47:26,392 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:47:26 INFO - 2015-12-04 04:47:26,392 DEBUG : BROWSER_OUTPUT: |0;Richards;168.49199663016006 04:47:26 INFO - 2015-12-04 04:47:26,394 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;183.99264029438822 04:47:26 INFO - 2015-12-04 04:47:26,394 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.9321845469705 04:47:26 INFO - 2015-12-04 04:47:26,394 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 04:47:26 INFO - 2015-12-04 04:47:26,394 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1092.896174863388 04:47:26 INFO - 2015-12-04 04:47:26,394 DEBUG : BROWSER_OUTPUT: |5;Earley;718.3908045977012 04:47:26 INFO - 2015-12-04 04:47:26,394 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 04:47:26 INFO - 2015-12-04 04:47:26,394 DEBUG : BROWSER_OUTPUT: |7;RegExp;25525 04:47:26 INFO - 2015-12-04 04:47:26,395 DEBUG : BROWSER_OUTPUT: |8;Splay;603.1363088057901 04:47:26 INFO - 2015-12-04 04:47:26,395 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4882.926829268293 04:47:26 INFO - 2015-12-04 04:47:26,395 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:47:26 INFO - 2015-12-04 04:47:26,395 DEBUG : BROWSER_OUTPUT: __startTimestamp1449233246391__endTimestamp 04:47:26 INFO - 2015-12-04 04:47:26,395 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,395 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:47:26 INFO - 2015-12-04 04:47:26,396 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:47:26 INFO - 2015-12-04 04:47:26,396 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,396 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.49 Median:168.49 stddev:0.00 (0.0%) 04:47:26 INFO - 2015-12-04 04:47:26,396 DEBUG : BROWSER_OUTPUT: Values: 168.5 04:47:26 INFO - 2015-12-04 04:47:26,396 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,396 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:183.99 Median:183.99 stddev:0.00 (0.0%) 04:47:26 INFO - 2015-12-04 04:47:26,397 DEBUG : BROWSER_OUTPUT: Values: 184.0 04:47:26 INFO - 2015-12-04 04:47:26,397 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,397 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 04:47:26 INFO - 2015-12-04 04:47:26,397 DEBUG : BROWSER_OUTPUT: Values: 277.9 04:47:26 INFO - 2015-12-04 04:47:26,397 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,397 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 04:47:26 INFO - 2015-12-04 04:47:26,398 DEBUG : BROWSER_OUTPUT: Values: 5202.1 04:47:26 INFO - 2015-12-04 04:47:26,398 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,398 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1092.90 Median:1092.90 stddev:0.00 (0.0%) 04:47:26 INFO - 2015-12-04 04:47:26,398 DEBUG : BROWSER_OUTPUT: Values: 1092.9 04:47:26 INFO - 2015-12-04 04:47:26,398 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,398 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:718.39 Median:718.39 stddev:0.00 (0.0%) 04:47:26 INFO - 2015-12-04 04:47:26,400 DEBUG : BROWSER_OUTPUT: Values: 718.4 04:47:26 INFO - 2015-12-04 04:47:26,400 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,400 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 04:47:26 INFO - 2015-12-04 04:47:26,400 DEBUG : BROWSER_OUTPUT: Values: 12268.3 04:47:26 INFO - 2015-12-04 04:47:26,400 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,400 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25525.00 Median:25525.00 stddev:0.00 (0.0%) 04:47:26 INFO - 2015-12-04 04:47:26,401 DEBUG : BROWSER_OUTPUT: Values: 25525.0 04:47:26 INFO - 2015-12-04 04:47:26,401 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,401 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.14 Median:603.14 stddev:0.00 (0.0%) 04:47:26 INFO - 2015-12-04 04:47:26,401 DEBUG : BROWSER_OUTPUT: Values: 603.1 04:47:26 INFO - 2015-12-04 04:47:26,401 DEBUG : BROWSER_OUTPUT: 04:47:26 INFO - 2015-12-04 04:47:26,401 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4882.93 Median:4882.93 stddev:0.00 (0.0%) 04:47:26 INFO - 2015-12-04 04:47:26,401 DEBUG : BROWSER_OUTPUT: Values: 4882.9 04:47:26 INFO - 2015-12-04 04:47:26,401 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:47:26 INFO - 2015-12-04 04:47:26,401 DEBUG : BROWSER_OUTPUT: 04:47:27 INFO - 2015-12-04 04:47:27,361 INFO : Browser exited with error code: 0 04:47:27 INFO - 2015-12-04 04:47:27,376 INFO : Completed test v8_7 (00:00:41) 04:47:27 INFO - 2015-12-04 04:47:27,409 INFO : Completed test suite (00:20:17) 04:47:27 INFO - 2015-12-04 04:47:27,409 DEBUG : Working with test: dromaeo_css 04:47:27 INFO - 2015-12-04 04:47:27,409 DEBUG : Generating results file: dromaeo_css 04:47:27 INFO - 2015-12-04 04:47:27,411 DEBUG : Working with test: kraken 04:47:27 INFO - 2015-12-04 04:47:27,411 DEBUG : Generating results file: kraken 04:47:27 INFO - 2015-12-04 04:47:27,411 INFO : javascript benchmark 04:47:27 INFO - 2015-12-04 04:47:27,411 DEBUG : Working with test: v8_7 04:47:27 INFO - 2015-12-04 04:47:27,411 DEBUG : Generating results file: v8_7 04:47:27 INFO - 2015-12-04 04:47:27,412 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:47:27 INFO - 2015-12-04 04:47:27,469 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:47:27 INFO - 2015-12-04 04:47:27,470 DEBUG : process_Request line: dromaeo_css 6218.23 graph.html#tests=[[72,94,43]] 04:47:27 INFO - 2015-12-04 04:47:27,470 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:47:27 INFO - 2015-12-04 04:47:27,500 DEBUG : process_Request line: kraken 1541.50 graph.html#tests=[[232,94,43]] 04:47:27 INFO - 2015-12-04 04:47:27,500 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:47:27 INFO - 2015-12-04 04:47:27,539 DEBUG : process_Request line: v8_7 21298.43 graph.html#tests=[[230,94,43]] 04:47:27 INFO - 2015-12-04 04:47:27,541 INFO : javascript benchmark 04:47:27 INFO - 2015-12-04 04:47:27,544 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2631.947361052779, 2666.6400035995134, 2678.183154137987, 2718.850463224523, 2724.087430710712, 4413.293872980324, 4673.789679464419, 4674.859754207375, 4704.3413922050895, 4720.976395118028, 4563.7489938053395, 4574.290984897338, 4588.151192029477, 4680.906381872361, 4695.436547614283, 4281.743095414277, 4355.54266801986, 4396.0, 4409.4708634963845, 4452.287633978564, 4330.523642399349, 4350.564943505656, 4359.673024523157, 4457.175422546839, 4471.552844715518, 4138.275801734714, 4210.536840947493, 4232.343986682069, 4337.436133302682, 4347.500037495681, 4353.477582690098, 4360.0, 4364.672649551297, 4373.497047839475, 4383.649308055348, 4344.608985191317, 4344.847930322455, 4364.127174565099, 4364.886953826785, 4406.339049142654, 4308.0, 4421.491528474235, 4530.728156310632, 4679.110968915895, 4682.836100736458, 4907.9263811042865, 4997.525235102659, 5000.924986125211, 5021.221710634857, 5069.923951140736, 5037.042961837239, 5042.621803364762, 5046.268291097807, 5050.7222102784335, 5096.643234973553, 4412.029353542215, 4514.751688657156, 4590.449146102423, 4675.29870519418, 4698.365720627671, 5191.8182863599595, 5194.454582268807, 5205.531502164823, 5229.267902493654, 5256.632035757537, 4733.148033354029, 4964.8510544682995, 4984.800607975641, 4989.525995030466, 5005.599552035828, 4896.824762057081, 4906.975465122651, 4953.777080031407, 4973.378327709036, 5019.723915184627, 4962.007598480246, 4984.127777638899, 4989.750512474362, 4998.350214472095, 5032.0, 4732.195526760459, 4801.903961920742, 4939.407271127416, 4946.183879659816, 4992.475790041994, 4072.1855628874346, 4085.20338533989, 4090.9590904091174, 4106.404571337199, 4151.294279972412, 3624.184558474375, 3639.890803275853, 3643.890683279506, 3678.5401824771902, 3680.3191409588776, 4044.130511939888, 4142.730722503088, 4180.122174343422, 4292.18448494785, 4313.6980411370905, 4988.90022199554, 5016.172331565251, 5030.320906677552, 5055.646104772704, 5064.518870707277, 4310.612044915973, 4323.740575565414, 4327.437433133672, 4344.674149438804, 4371.322445021026, 4184.330507118846, 4253.48958125027, 4278.229918614679, 4378.934315985262, 4447.332900064951, 4764.213904705754, 4802.471728109836, 4809.326694262806, 4814.277858321279, 4837.129316723023, 5064.898702026013, 5078.390593128848, 5093.261477085876, 5102.642815002914, 5138.640295179451, 4551.817927282872, 4613.700109492872, 4624.28323609841, 4671.76641167947, 4768.61851051922, 4936.950630493793, 4943.480934501826, 4955.242966751958, 4970.900581988268, 4983.800647974185, 5037.874053148701, 5041.0, 5048.596112310933, 5056.292119103255, 5108.514691104339, 4613.630909527163, 4735.715857048588, 4742.525747425368, 4806.351142595845, 4846.418429788448, 4817.5182481752945, 4877.90244195107, 4881.755912204305, 4882.584980276574, 4925.482824303396, 4578.748168850745, 4793.304970779287, 4804.35141255926, 4806.0, 4850.951490485191, 4791.952080479151, 4810.42274927011, 4854.80580776765, 4857.417109946829, 4900.8774780630765, 4739.691920025325, 4810.759462026955, 4810.855674329776, 4828.396450443694, 4884.998575291986], "unit": "ms", "name": "dojo.html", "value": 4577.706038586458}, {"lowerIsBetter": false, "replicates": [556.1352097488406, 559.3064599896128, 565.9462351076648, 586.0769288370815, 621.679834885034, 36900.0, 37362.43956340657, 37739.622603773954, 37768.0, 37850.62149378505, 37313.626863731355, 37814.4327835082, 37925.81037094811, 38009.04977375567, 38020.23959520808, 7532.359749421292, 7726.497777644463, 7730.574818384986, 7732.884006739903, 7736.0, 7588.734394296201, 7589.962050189742, 7663.846723065535, 7685.5388676679295, 7705.383569314441, 7529.887051694229, 7573.091229052521, 7610.35311998478, 7615.5811430371305, 7629.961850190742, 7767.766966990971, 7800.687972481122, 7822.882656760153, 7842.960785196095, 7851.45039847211, 7744.922550774477, 7765.495242809199, 7782.883256751154, 7817.530948143073, 7821.296083352526, 35216.29567408663, 35795.64204357949, 35805.82097089498, 35873.46189807155, 35929.82035089834, 2759.1998320487237, 2870.2680816391894, 3005.323802144522, 3440.673136052071, 3583.6953858922025, 28142.15573532797, 28410.147695569165, 28436.28909277264, 28728.42543149146, 28765.56851647206, 3279.360524697685, 3482.0, 3524.8766293179874, 3535.7878527288444, 3562.679358857715, 216333.0, 216459.0, 216693.0, 217273.0, 217550.0, 51724.482755171965, 53296.20055699167, 55390.44609553853, 55560.44439555633, 56061.0, 65526.0, 66281.0, 66866.66566667135, 66897.66551167212, 67089.0, 12998.285094319714, 13038.348082595832, 13097.869021309856, 13109.344532773513, 13169.078164528582, 9538.141567258841, 9570.665026724031, 9582.28132890036, 9602.759931001781, 9627.0, 19245.467516787776, 19545.90227048884, 19618.411447656592, 19626.313079042164, 19690.507737306394, 7514.323710866049, 7621.771346859603, 7705.961470192613, 7751.34113600339, 7751.806204844811, 831.3100126894662, 892.3307519360479, 894.4409743910056, 917.2249449215402, 934.3506263147184, 25002.624960625606, 25906.0, 25915.611265831027, 26028.86985565098, 26180.476390472464, 947.5499137909438, 970.2819913264275, 1015.791762688647, 1048.3395460859763, 1049.6168898352046, 13424.597262082154, 13437.193768373929, 13452.0, 13583.0, 13721.519746809014, 330209.3489532537, 332299.0, 332781.0, 334433.0, 334607.0, 48091.519084809406, 48823.267650984555, 49032.75483622559, 49091.509084909405, 49094.75452622714, 1201.549418967887, 1208.788462019143, 1212.1636071111081, 1214.089432925306, 1223.3516236394726, 25014.37464063413, 25713.742862571136, 26063.73936260613, 26249.212523624323, 26298.60552091682, 37652.05869853166, 38196.0, 38214.80892595519, 38268.0, 38318.23363532769, 248104.0, 249380.0, 251301.0, 251541.0, 253505.0, 29832.0, 35054.824725876206, 38910.6108938907, 41758.58241417547, 43266.13467730565, 39602.0, 39963.0, 40446.1910761789, 40770.38844417396, 41076.0, 33308.666913330555, 33671.3265734679, 34393.65606343905, 34616.48075278822, 35105.29789404147, 36721.63278367289, 38044.61955380411, 38294.80852595719, 38340.55049524707, 38852.222955540165, 33947.32105357928, 34419.483707744905, 34422.48366274458, 34589.48115778215, 34605.0, 29544.409111817215, 30466.0, 31010.224744381572, 31031.84484077565, 31076.0, 24143.56279873536, 24427.0, 24437.38906527351, 24784.884680189076, 24810.37974050591], "unit": "ms", "name": "ext.html", "value": 17177.150882119375}, {"lowerIsBetter": false, "replicates": [300.88115194498187, 307.88300445830583, 313.3842000469078, 319.25135557118557, 325.05247204399177, 14643.0, 15046.097234165944, 15146.84853151468, 15657.373705051812, 16417.261223244954, 9177.08229177082, 9396.859047114282, 11028.779424411507, 13526.729465410686, 13540.59378218655, 4542.250528662767, 4549.363089167519, 4670.439547254335, 4677.83627573035, 4681.110588988098, 4597.724136551801, 4616.492185859553, 4629.120467111238, 4632.050429661911, 4652.13935421948, 3389.57630296213, 3484.878029268976, 4632.559906808848, 4634.420697412824, 5233.555147812441, 5372.946270537283, 5397.028534863723, 5405.702686352249, 5405.918911216335, 5436.2661040759585, 4697.600703940169, 4806.927896081562, 4814.638902082358, 5172.793088276464, 5214.97392513035, 10592.523336449802, 10985.01134897863, 11262.267952583055, 11352.94323528377, 11401.0, 1853.5458812590866, 1886.5849513107094, 1931.6812725900209, 1938.8255057044792, 2173.2067795254775, 8988.77528061797, 9301.255899528021, 11610.942551110133, 11938.701532461671, 12399.318037507934, 1694.9152542372833, 1711.4352263752933, 1737.9826201737947, 1775.3874913154941, 1781.234069350179, 54899.0, 56216.71891640557, 56654.15018774722, 56812.715936420056, 57920.0, 9390.436573805593, 9418.10527999839, 9477.90522094784, 9521.619135234652, 9532.618695252113, 11826.467808948619, 11836.644900652995, 11861.703457413634, 11881.88118118825, 11928.880711192951, 6481.384268494486, 6644.83387915306, 6706.094677218513, 6715.1941766988275, 6808.080909077211, 6201.162843016225, 6228.532860035515, 6258.937410625836, 6280.026595877646, 6288.182536270256, 3926.391409331558, 3959.089409435788, 3973.0, 3974.940375894364, 3994.1013272014147, 1570.7800907872906, 1588.769628403898, 1710.42700695266, 1715.082430899463, 1737.409280844519, 357.9266250418658, 360.3279883018205, 393.75587135975877, 840.4537050916831, 894.3113802372137, 9563.521823908777, 15300.846991530165, 15305.6990155838, 15572.299246533934, 15836.683266334609, 859.7979474823411, 903.2277402820494, 904.4618452021037, 947.1286416496839, 984.468387070988, 8988.280937524982, 9197.81604367909, 9313.301502387349, 9382.202512786353, 9629.0, 306293.0, 309280.0, 315326.0, 476669.0, 481963.0, 60945.0, 62538.374616254165, 63260.367396326365, 65059.67470162713, 65386.346136538974, 408.7179845906315, 412.9566395528426, 416.1468988573473, 416.83326669331905, 417.39686153507887, 9279.350445468752, 9293.349465537347, 9441.952790236004, 9740.318177727491, 10065.245106616887, 32961.505577416836, 34259.31481370309, 35118.12204694903, 35382.64617353897, 35535.28929421449, 40718.796406017784, 40721.0, 41473.0, 42424.36363454613, 43826.342604860314, 8292.253697167043, 8583.098774628825, 8662.523561203941, 8775.0, 8813.691520796741, 8321.791955201168, 10438.582456701646, 15482.0, 15776.13231272291, 15782.289796959394, 11862.228955118235, 13799.517016904761, 13815.861841381458, 14082.507112251433, 14475.855241447873, 12587.433565489391, 12628.179168354027, 12735.108542402313, 12998.545050923172, 13106.475740970636, 13216.207027578375, 13449.663758405726, 13507.864921350661, 13640.181589104686, 13655.590332290047, 8751.343649226206, 8808.779780505538, 8907.73276801697, 8942.552872356486, 8989.775255618662, 8847.778805529913, 9003.63985440575, 12995.28525931083, 13255.734885302047, 13397.933010334886], "unit": "ms", "name": "jquery.html", "value": 7452.459522143074}, {"lowerIsBetter": false, "replicates": [1478.438193486475, 1656.6935117003354, 1673.2303140555343, 1708.8632909367243, 1735.5487573230964, 6108.3586223446455, 6231.096491008801, 6629.469642428606, 7128.643567821614, 7130.393916517096, 6586.748517781618, 6709.127813384265, 6729.7644582439625, 6748.122744043279, 6752.459803215743, 2041.9999999999964, 2084.9791502084936, 2095.2561840546614, 2096.3186964236606, 2096.8008039236247, 2083.291680828518, 2112.0284669052253, 2123.5115923337644, 2145.0, 2155.181031208139, 2015.0932080563805, 2016.5059560407722, 2032.7459067616549, 2034.206659402834, 2039.276056999766, 2048.201201531404, 2061.3815855243365, 2070.9378718638463, 2072.450800537851, 2072.875627462357, 2052.5381789097482, 2086.9165233390645, 2100.5168811173517, 2107.525806693497, 2113.778053304396, 6986.860262794716, 7035.542689725203, 7067.89398159028, 7080.468964827607, 7093.0, 4017.718759686823, 4062.695297852673, 4091.5908409158847, 4092.7953602320063, 4093.8362465501345, 2759.1308737747745, 2776.7917406194615, 2798.6641603007565, 2833.702461241581, 2851.543752999531, 907.9319051071196, 1667.2164082881147, 1668.57451349905, 1710.4441056656635, 1723.2331612432472, 9110.908890911138, 9293.860592091056, 9295.11696388842, 9304.72085837426, 9313.720588382359, 3739.775613463201, 3765.604611515806, 3818.2554401891366, 3824.655780979725, 3907.7264591478324, 7693.192214817475, 7696.884546731803, 7699.153093159748, 7707.961460192775, 7733.651985660659, 4066.268071747055, 4073.918521629551, 4087.305158123126, 4124.443200167939, 4129.2773764591075, 3217.8069315840658, 3298.1919429739387, 3653.725970552219, 3728.9440658390145, 3731.570869350005, 3193.1857376369344, 3200.6639302873327, 3220.710136087763, 3277.8688852445634, 3286.7699261051976, 938.7324612485409, 966.5650457294246, 967.4098799732158, 968.1431932739576, 969.7866469376726, 1073.3023534702506, 1098.1434481104752, 1131.298594871185, 1149.7987852125846, 1154.2901115813713, 6559.114519539897, 6638.900416493757, 6668.7329407412435, 6686.7993960181275, 6716.630585317855, 422.2294312879008, 427.3884783189352, 429.5682838747102, 430.9396684464177, 432.9437173167468, 5266.1574148136115, 5323.600729945192, 5333.786648534093, 5341.225522299244, 5346.7861285548925, 8075.0, 8145.266925976691, 8211.876821847676, 8287.088420273765, 8421.15788421153, 8273.33813294935, 8295.792605184919, 8299.875501867476, 8335.208155225244, 8363.247307742333, 6014.278286605548, 6221.96889015552, 6264.467520260829, 6265.154204182377, 6267.373262673696, 6557.770478033246, 6558.704858281484, 6580.5722628029025, 6603.075569420189, 6610.173728283965, 7228.421726261781, 7263.382612477787, 7356.852862942818, 7369.226231245642, 7385.335319821242, 7445.0, 7499.812504687208, 7545.0, 7602.923970760222, 7606.581638009962, 5344.144936810092, 5428.511433970962, 5945.821625351246, 5958.493528050164, 6023.548233882564, 6596.80209593713, 6701.463882889455, 6727.260001399744, 6740.595564266159, 6755.459563234831, 6211.9068213975925, 6278.372162783685, 6363.904541431974, 6404.839879003062, 6495.805125846232, 6258.092576576462, 6271.372862713874, 6320.841978950563, 6378.585391949508, 6454.644994525158, 6405.295417503978, 6438.806835794933, 6450.161479007699, 6458.935410645833, 6477.190351206099, 5916.55625828056, 5918.763249469973, 5946.583739138218, 5954.37479064692, 5963.52291816645, 5893.823185304448, 5973.402659733992, 5992.400759923973, 5995.88008239824, 5999.820005399845], "unit": "ms", "name": "mootools.html", "value": 3982.2276179823307}, {"lowerIsBetter": false, "replicates": [278.729632256711, 285.6900263214412, 287.7151619896303, 287.87477447310437, 289.083604972238, 5371.462853714626, 5470.179473079035, 5509.090999984997, 5569.749361278742, 5599.63602365846, 5519.889602207963, 5524.171374293858, 5525.834224973247, 5530.0, 5532.225488431613, 4225.04936389313, 4225.176090662322, 4238.321868501041, 4250.319948808191, 4252.8511502097435, 4250.957490425102, 4264.97867510662, 4267.189234045537, 4270.57294270572, 4270.97864510677, 4160.251154792151, 4211.199872024321, 4231.428757117796, 4231.576842315759, 4238.788060596973, 4234.195502854448, 4237.978810105945, 4238.152369526077, 4238.470191226097, 4239.682023848209, 3673.430618254175, 3677.4922281864574, 3679.411294192916, 3686.612905644922, 3689.501917241165, 5301.973490132563, 5304.761285742113, 5331.306930099101, 5353.437889021636, 5356.812511562116, 4565.497795242521, 4844.467108618049, 4862.659613827033, 4863.8297659582095, 4872.926906096412, 5611.943880561183, 5746.166805813175, 5758.309002919635, 5762.827115186551, 5763.049096899007, 3795.69634429245, 3800.9809950950344, 3802.4106263529197, 3804.201117765245, 3815.751976121571, 6016.699165041774, 6017.578769486137, 6081.483073938721, 6086.2087928569, 6106.816795496098, 3890.5216017913012, 3948.486696729407, 3957.2679054375035, 3974.523057233093, 3981.9402708959387, 3995.780232087263, 3998.2403343364667, 4024.476818013698, 4025.6376926076796, 4028.858989935397, 4667.229907065296, 4671.976640116778, 4686.484486706459, 4695.9668872847915, 4715.386999690087, 5759.798407055733, 5759.913601295984, 5769.1634712967225, 5780.913286300709, 5791.333996590446, 1399.7130588229388, 1399.9580012599638, 1400.250865786799, 1400.4608225832924, 1401.1523028567774, 886.5301390263171, 927.9072092790802, 930.4417349590327, 933.2627224492575, 946.0775743650024, 4971.552560269593, 4982.427020892571, 4984.451710311862, 4989.55094041538, 4995.275685025651, 5948.10778383246, 5952.166696662471, 5955.404459554096, 5963.970180149158, 5981.581289309706, 4983.327250821093, 4989.376327959005, 4990.8253211137435, 4999.0501804657, 4999.425066117443, 3172.762042846796, 3183.5383869338816, 3231.579894613685, 3252.6259480160084, 3269.313444176702, 5710.65736055838, 5748.9425105748405, 5754.856128596819, 5755.194272801811, 5759.049756790083, 6206.286277078104, 6250.843728906813, 6267.2165979252595, 6273.1844860167885, 6275.497960163268, 5612.818036696124, 5689.9146512802345, 5695.971520142372, 5723.656580605177, 5731.111677689964, 6030.547708921761, 6043.425874541911, 6050.9394906050375, 6079.756809727738, 6087.908681369694, 5895.734691938787, 5905.645661260338, 5912.645241285537, 5921.61509501881, 5941.970290148522, 5661.150827375926, 5664.85837854057, 5689.061304884648, 5713.114467257582, 5718.342390625131, 3796.5064541609413, 3930.6265904739003, 3954.822033008464, 3960.3267444535077, 3961.5246170459727, 5986.790462333797, 5995.2206213192, 6012.789552365821, 6021.849453763691, 6025.578209525291, 5795.536357091339, 5799.82600521985, 5800.39095894925, 5809.506191973561, 5812.476877080914, 5667.0, 5753.108268218432, 5794.391588883106, 5810.186573879576, 5849.970750146222, 5708.628939118944, 5708.743106560131, 5713.571482138939, 5717.1138473535, 5719.113537401709, 5816.47651711348, 5856.560757943086, 5867.354590994902, 5871.1486834409625, 5881.7647294107755, 5530.695811730394, 5696.458836410535, 5745.425457454221, 5754.741036653277, 5757.8560535986935], "unit": "ms", "name": "prototype.html", "value": 4289.53398881308}, {"lowerIsBetter": false, "replicates": [762.9542227466352, 767.9270469305415, 774.0950719581334, 777.5684495105214, 786.7718361675114, 11515.193936424454, 11944.044476441886, 11947.402629868515, 11978.820317695241, 12002.759944801099, 11357.318560886331, 11530.135239857023, 11549.249298795572, 11556.768864622703, 11588.826167607493, 627.5105417774121, 636.5353292096772, 794.1105961323326, 804.493169303338, 809.324214281076, 789.0, 794.0392125528118, 797.5374282915894, 798.0822054637156, 802.2018091998441, 848.7708318753932, 853.731074711467, 854.8589482735341, 857.6355049104137, 861.0786458489418, 845.6194712379454, 846.9068402475723, 849.0405841399241, 851.535912927456, 853.6926706385697, 629.8488362792942, 630.124127462827, 631.1038325577645, 633.0219810392954, 633.1610615933906, 12400.81398779019, 12447.190932589352, 12475.438605262785, 12558.183718058297, 12570.30863302518, 10833.891661083368, 11378.544858205662, 11504.137189710806, 11658.941705291503, 11727.296362218294, 9162.541872906328, 9178.908210917873, 9209.217216536603, 9327.160555550034, 9428.292878034106, 3216.6140063192565, 3288.44096503595, 3319.9004029879143, 3321.8671253149846, 3332.0836769888233, 39983.0, 40068.0, 40100.0, 40344.798276008434, 40592.0, 9014.0, 9396.966333703287, 9562.904370956341, 9585.952070239604, 9612.951935240419, 16181.919090404472, 16367.0, 16430.75353869693, 16439.83560164383, 16454.177291135395, 6107.816765497042, 6196.783112591038, 6241.313455519889, 6308.211473565804, 6520.217573891164, 3431.3823511768123, 3450.1202193440513, 3573.874914377984, 3595.532580764484, 3716.7769933804057, 2742.314421394651, 2766.8754906028876, 2768.169549135251, 2771.4457108577963, 2772.209920172741, 501.34824727854374, 508.7227461033672, 510.64765311934644, 512.7846304552022, 526.4971951786035, 561.7752898840497, 587.2483221476517, 615.0, 624.3756243756244, 643.9903401448983, 7049.718011279491, 7738.7678369649, 7838.0, 7869.645865936047, 7912.762617121495, 556.5213916032209, 599.1671576508656, 614.8616561273767, 623.5635055461196, 624.978125765596, 3544.971958132113, 3662.7436079474714, 3670.3436235219365, 3682.116292089933, 3682.705383569308, 52059.219111713355, 52211.73894130505, 52449.475505245224, 52833.7358313206, 52940.470595294326, 47249.76375118171, 47527.0, 48096.7595162022, 48231.0, 48310.5168948306, 42082.78958605188, 43028.354574681405, 43304.56695433131, 43435.0, 43736.12527749491, 7037.577745335297, 7042.190148132825, 7102.4673149512955, 7166.498345115792, 7185.712571497082, 32500.0, 33651.66348336485, 33714.3257134851, 34262.31475370429, 34866.30267394587, 39911.40132897951, 39984.600153998086, 40509.0, 41851.7907410461, 42070.78964605158, 10195.643152489627, 10211.336263142872, 10270.948645256725, 10407.21945854079, 10780.568777249136, 10467.895321046997, 10809.621663241749, 10907.072898803373, 10912.236143470198, 10918.727031824268, 10584.153267738408, 10607.893921060691, 10712.143028557852, 10820.0, 10829.837552436877, 10359.274850760676, 10534.0, 10585.523651435858, 10621.415822129547, 10994.780104398027, 10686.57253709874, 10764.138868890626, 10784.245102842726, 10797.460126993776, 10857.239993200401, 8383.95808020956, 8445.0, 8477.74566762998, 8668.739937801876, 8772.122787721177, 7737.0, 8356.456830306011, 8368.581570921551, 8441.198086181803, 8475.533845638549], "unit": "ms", "name": "yui.html", "value": 5774.557169242561}], "name": "dromaeo_css", "value": 6218.224560980683}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 113.0, 113.0, 113.0, 124.0, 114.0, 112.0, 113.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 113.7}, {"lowerIsBetter": true, "replicates": [160.0, 129.0, 158.0, 172.0, 132.0, 168.0, 151.0, 130.0, 175.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.8}, {"lowerIsBetter": true, "replicates": [165.0, 164.0, 162.0, 162.0, 163.0, 178.0, 166.0, 162.0, 164.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 165.0}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 73.0, 79.0, 138.0, 71.0, 80.0, 73.0, 72.0, 90.0], "unit": "ms", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 129.0, 95.0, 95.0, 94.0, 131.0, 94.0, 95.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 111.0, 118.0, 111.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.8}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 146.0, 148.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 72.0, 72.0, 73.0, 75.0, 74.0, 82.0, 70.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 73.5}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 67.0, 71.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 85.0, 86.0, 86.0, 85.0, 86.0, 87.0, 88.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.5}, {"lowerIsBetter": true, "replicates": [123.0, 137.0, 129.0, 126.0, 126.0, 123.0, 126.0, 119.0, 121.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [137.0, 148.0, 147.0, 151.0, 147.0, 139.0, 145.0, 148.0, 148.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 69.0, 70.0, 70.0, 69.0, 69.0, 68.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1541.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.49199663016006], "unit": "score", "name": "Richards", "value": 209.51736999999997}, {"lowerIsBetter": false, "replicates": [183.99264029438822], "unit": "score", "name": "DeltaBlue", "value": 359.35133}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1092.896174863388], "unit": "score", "name": "RayTrace", "value": 677.089935}, {"lowerIsBetter": false, "replicates": [718.3908045977012], "unit": "score", "name": "Earley", "value": 927.7164960000002}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [25525.0], "unit": "score", "name": "RegExp", "value": 35.689911851126354}, {"lowerIsBetter": false, "replicates": [603.1363088057901], "unit": "score", "name": "Splay", "value": 135.11207800000005}, {"lowerIsBetter": false, "replicates": [4882.926829268293], "unit": "score", "name": "NavierStokes", "value": 303.91608391608383}], "name": "v8_7", "value": 21298.43306875763}]} 04:47:27 INFO - RETURN: dromaeo_css: 6218.23 04:47:27 INFO - RETURN: kraken: 1541.50 04:47:27 INFO - RETURN: v8_7: 21298.43 04:47:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21298.43"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1541.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6218.23"}}} 04:47:27 INFO - Return code: 0 04:47:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:47:27 INFO - # TBPL SUCCESS # 04:47:27 INFO - Running post-action listener: _resource_record_post_action 04:47:27 INFO - Running post-run listener: _resource_record_post_run 04:47:28 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 503554048; Read time: 12; Write time: 829768 04:47:28 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 230928384; Read time: 0; Write time: 461476 04:47:28 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271634432; Read time: 12; Write time: 368244 04:47:28 INFO - Running post-run listener: _upload_blobber_files 04:47:28 INFO - Blob upload gear active. 04:47:28 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:47:28 INFO - Copying logs to upload dir... 04:47:28 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.743543 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-12-04 04:47:28.361233) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:47:28.364904) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010086 build_url: 'https://queue.taskcluster.net/v1/task/z2L0-EeSQdGCw-ehUn5ohw/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-12-04 04:47:28.420558) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:47:28.421306) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1449231864.792848-373104242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:47:28.475825) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 04:47:28.476588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 04:47:28.477257) ========= ========= Total master_lag: 0.25 =========