builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1450292193.37 results: success (0) buildid: 20151216101138 builduid: c14a76ad50ee4feba7919d9cee80cc50 revision: e735b7607ae25e5769d49fb848292d56889330fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.370901) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.371346) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.371665) ========= 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=6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006359 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.398867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.399196) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.420163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.420495) ========= 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=6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004678 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.470399) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.470741) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.471144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.471465) ========= 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=6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 10:56:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.9M=0s 2015-12-16 10:56:33 (59.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142126 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.626252) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.626601) ========= 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=6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022493 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:33.680342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 10:56:33.680786) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e735b7607ae25e5769d49fb848292d56889330fe --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e735b7607ae25e5769d49fb848292d56889330fe --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=6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 10:56:33,917 truncating revision to first 12 chars 2015-12-16 10:56:33,917 Setting DEBUG logging. 2015-12-16 10:56:33,917 attempt 1/10 2015-12-16 10:56:33,917 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e735b7607ae2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 10:56:34,958 unpacking tar archive at: fx-team-e735b7607ae2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.311729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-16 10:56:35.006548) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:35.007011) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:35.016484) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:35.016951) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:35.017485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-16 10:56:35.017876) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:56:35 INFO - MultiFileLogger online at 20151216 10:56:35 in /builds/slave/test 10:56:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:56:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:56:35 INFO - {'append_to_log': False, 10:56:35 INFO - 'base_work_dir': '/builds/slave/test', 10:56:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:56:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:56:35 INFO - 'branch': 'Fx-Team-Non-PGO', 10:56:35 INFO - 'buildbot_json_path': 'buildprops.json', 10:56:35 INFO - 'config_files': ('talos/linux_config.py',), 10:56:35 INFO - 'default_actions': ('clobber', 10:56:35 INFO - 'read-buildbot-config', 10:56:35 INFO - 'download-and-extract', 10:56:35 INFO - 'populate-webroot', 10:56:35 INFO - 'create-virtualenv', 10:56:35 INFO - 'install', 10:56:35 INFO - 'run-tests'), 10:56:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:56:35 INFO - 'download_minidump_stackwalk': True, 10:56:35 INFO - 'download_symbols': 'ondemand', 10:56:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:56:35 INFO - 'tooltool.py': '/tools/tooltool.py', 10:56:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:56:35 INFO - '/tools/misc-python/virtualenv.py')}, 10:56:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:56:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:56:35 INFO - 'installer_path': 'installer.exe', 10:56:35 INFO - 'log_level': 'info', 10:56:35 INFO - 'log_name': 'talos', 10:56:35 INFO - 'log_to_console': True, 10:56:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:56:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:56:35 INFO - 'opt_config_files': (), 10:56:35 INFO - 'pip_index': False, 10:56:35 INFO - 'sps_profile': False, 10:56:35 INFO - 'sps_profile_interval': 0, 10:56:35 INFO - 'suite': 'dromaeojs-e10s', 10:56:35 INFO - 'system_bits': '64', 10:56:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:56:35 INFO - 'title': 'talos-linux64-ix-018', 10:56:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:56:35 INFO - 'use_talos_json': True, 10:56:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:56:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:56:35 INFO - 'work_dir': 'build'} 10:56:35 INFO - ##### 10:56:35 INFO - ##### Running clobber step. 10:56:35 INFO - ##### 10:56:35 INFO - Running pre-action listener: _resource_record_pre_action 10:56:35 INFO - Running main action method: clobber 10:56:35 INFO - rmtree: /builds/slave/test/build 10:56:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:56:36 INFO - Running post-action listener: _resource_record_post_action 10:56:36 INFO - ##### 10:56:36 INFO - ##### Running read-buildbot-config step. 10:56:36 INFO - ##### 10:56:36 INFO - Running pre-action listener: _resource_record_pre_action 10:56:36 INFO - Running main action method: read_buildbot_config 10:56:36 INFO - Using buildbot properties: 10:56:36 INFO - { 10:56:36 INFO - "properties": { 10:56:36 INFO - "buildnumber": 588, 10:56:36 INFO - "product": "firefox", 10:56:36 INFO - "script_repo_revision": "production", 10:56:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:56:36 INFO - "repository": "", 10:56:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:56:36 INFO - "buildid": "20151216101138", 10:56:36 INFO - "slavename": "talos-linux64-ix-018", 10:56:36 INFO - "pgo_build": "False", 10:56:36 INFO - "basedir": "/builds/slave/test", 10:56:36 INFO - "project": "", 10:56:36 INFO - "platform": "ubuntu64_hw", 10:56:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:56:36 INFO - "slavebuilddir": "test", 10:56:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:56:36 INFO - "branch": "fx-team", 10:56:36 INFO - "repo_path": "integration/fx-team", 10:56:36 INFO - "stage_platform": "linux64", 10:56:36 INFO - "builduid": "c14a76ad50ee4feba7919d9cee80cc50", 10:56:36 INFO - "revision": "e735b7607ae25e5769d49fb848292d56889330fe" 10:56:36 INFO - }, 10:56:36 INFO - "sourcestamp": { 10:56:36 INFO - "repository": "", 10:56:36 INFO - "hasPatch": false, 10:56:36 INFO - "project": "", 10:56:36 INFO - "branch": "fx-team-linux64-talos", 10:56:36 INFO - "changes": [ 10:56:36 INFO - { 10:56:36 INFO - "category": null, 10:56:36 INFO - "files": [ 10:56:36 INFO - { 10:56:36 INFO - "url": null, 10:56:36 INFO - "name": "https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 10:56:36 INFO - } 10:56:36 INFO - ], 10:56:36 INFO - "repository": "", 10:56:36 INFO - "rev": "e735b7607ae25e5769d49fb848292d56889330fe", 10:56:36 INFO - "who": "pbrosset@mozilla.com", 10:56:36 INFO - "when": 1450292151, 10:56:36 INFO - "number": 7367596, 10:56:36 INFO - "comments": "Bug 1224932 - Center the element in the layout-view; r=bgrins", 10:56:36 INFO - "project": "", 10:56:36 INFO - "at": "Wed 16 Dec 2015 10:55:51", 10:56:36 INFO - "branch": "fx-team-linux64-talos", 10:56:36 INFO - "revlink": "", 10:56:36 INFO - "properties": [ 10:56:36 INFO - [ 10:56:36 INFO - "buildid", 10:56:36 INFO - "20151216101138", 10:56:36 INFO - "Change" 10:56:36 INFO - ], 10:56:36 INFO - [ 10:56:36 INFO - "builduid", 10:56:36 INFO - "c14a76ad50ee4feba7919d9cee80cc50", 10:56:36 INFO - "Change" 10:56:36 INFO - ], 10:56:36 INFO - [ 10:56:36 INFO - "pgo_build", 10:56:36 INFO - "False", 10:56:36 INFO - "Change" 10:56:36 INFO - ] 10:56:36 INFO - ], 10:56:36 INFO - "revision": "e735b7607ae25e5769d49fb848292d56889330fe" 10:56:36 INFO - } 10:56:36 INFO - ], 10:56:36 INFO - "revision": "e735b7607ae25e5769d49fb848292d56889330fe" 10:56:36 INFO - } 10:56:36 INFO - } 10:56:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:56:36 INFO - Running post-action listener: _resource_record_post_action 10:56:36 INFO - ##### 10:56:36 INFO - ##### Running download-and-extract step. 10:56:36 INFO - ##### 10:56:36 INFO - Running pre-action listener: _resource_record_pre_action 10:56:36 INFO - Running main action method: download_and_extract 10:56:36 INFO - mkdir: /builds/slave/test/build/tests 10:56: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')]} 10:56:36 INFO - https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:56:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/test_packages.json 10:56:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/test_packages.json 10:56:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:56:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:56:38 INFO - Downloaded 1302 bytes. 10:56:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:56:38 INFO - Using the following test package requirements: 10:56:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:56:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'jsshell-linux-x86_64.zip'], 10:56:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:56:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:56:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:56:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:56:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:56:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:56: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')]} 10:56:38 INFO - https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:56:40 INFO - Downloaded 21870297 bytes. 10:56:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:56:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:56:41 INFO - Return code: 0 10:56:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:56: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')]} 10:56:41 INFO - https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:56:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:56:46 INFO - Downloaded 21870297 bytes. 10:56:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:56:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:56:47 INFO - Return code: 0 10:56:47 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')]} 10:56:47 INFO - https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:56:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:56:49 INFO - Downloaded 11132052 bytes. 10:56:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 10:56:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:56:49 INFO - Return code: 0 10:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:49 INFO - https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:56:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:56:51 INFO - Downloaded 57745490 bytes. 10:56:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:51 INFO - mkdir: /builds/slave/test/properties 10:56:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:56:51 INFO - Writing to file /builds/slave/test/properties/build_url 10:56:51 INFO - Contents: 10:56:51 INFO - build_url:https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:51 INFO - Running post-action listener: _resource_record_post_action 10:56:51 INFO - Running post-action listener: set_extra_try_arguments 10:56:51 INFO - ##### 10:56:51 INFO - ##### Running populate-webroot step. 10:56:51 INFO - ##### 10:56:51 INFO - Running pre-action listener: _resource_record_pre_action 10:56:51 INFO - Running main action method: populate_webroot 10:56:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:56:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:56:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:56:51 INFO - '--tppagecycles', 10:56:51 INFO - '7'], 10:56:51 INFO - 'tests': ['tsvgm']}}, 10:56:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:56:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:56:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:56:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:56:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'tests': ['damp', 'tps']}, 10:56:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['damp', 'tps']}, 10:56:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:56:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:56:51 INFO - 'other': {'tests': ['a11yr', 10:56:51 INFO - 'ts_paint', 10:56:51 INFO - 'tpaint', 10:56:51 INFO - 'sessionrestore', 10:56:51 INFO - 'sessionrestore_no_auto_restore']}, 10:56:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['a11yr', 10:56:51 INFO - 'ts_paint', 10:56:51 INFO - 'tpaint', 10:56:51 INFO - 'sessionrestore', 10:56:51 INFO - 'sessionrestore_no_auto_restore']}, 10:56:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['a11yr', 10:56:51 INFO - 'ts_paint', 10:56:51 INFO - 'tpaint', 10:56:51 INFO - 'sessionrestore', 10:56:51 INFO - 'sessionrestore_no_auto_restore']}, 10:56:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['a11yr', 10:56:51 INFO - 'ts_paint', 10:56:51 INFO - 'tpaint', 10:56:51 INFO - 'sessionrestore', 10:56:51 INFO - 'sessionrestore_no_auto_restore']}, 10:56:51 INFO - 'other_l64': {'tests': ['a11yr', 10:56:51 INFO - 'ts_paint', 10:56:51 INFO - 'tpaint', 10:56:51 INFO - 'sessionrestore', 10:56:51 INFO - 'sessionrestore_no_auto_restore']}, 10:56:51 INFO - 'other_nol64': {'tests': ['a11yr', 10:56:51 INFO - 'ts_paint', 10:56:51 INFO - 'tpaint', 10:56:51 INFO - 'sessionrestore', 10:56:51 INFO - 'sessionrestore_no_auto_restore']}, 10:56:51 INFO - 'svgr': {'tests': ['tsvgx', 10:56:51 INFO - 'tsvgr_opacity', 10:56:51 INFO - 'tart', 10:56:51 INFO - 'tscrollx', 10:56:51 INFO - 'cart']}, 10:56:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['tsvgx', 10:56:51 INFO - 'tsvgr_opacity', 10:56:51 INFO - 'tart', 10:56:51 INFO - 'tscrollx', 10:56:51 INFO - 'cart']}, 10:56:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'tests': ['tp5o']}, 10:56:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['tp5o']}, 10:56:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'talos_options': ['--xperf_path', 10:56:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:51 INFO - 'tests': ['tp5n']}, 10:56:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'talos_options': ['--e10s', 10:56:51 INFO - '--xperf_path', 10:56:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:51 INFO - 'tests': ['tp5n']}}, 10:56:51 INFO - 'talos.zip': {'path': '', 10:56:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:56:51 INFO - Running post-action listener: _resource_record_post_action 10:56:51 INFO - ##### 10:56:51 INFO - ##### Running create-virtualenv step. 10:56:51 INFO - ##### 10:56:51 INFO - Running pre-action listener: _resource_record_pre_action 10:56:51 INFO - Running main action method: create_virtualenv 10:56:51 INFO - Creating virtualenv /builds/slave/test/build/venv 10:56:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:56:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:56:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:56:51 INFO - Using real prefix '/usr' 10:56:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:56:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:56:54 INFO - Installing pip.................done. 10:56:54 INFO - Return code: 0 10:56:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef2a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf320b0>, '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 0xf32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf33440>, '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': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', '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 10:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:56:54 INFO - Using env: {'DISPLAY': ':0', 10:56:54 INFO - 'HOME': '/home/cltbld', 10:56:54 INFO - 'LANG': 'en_US.UTF-8', 10:56:54 INFO - 'LANGUAGE': 'en_US:en', 10:56:54 INFO - 'LOGNAME': 'cltbld', 10:56:54 INFO - 'MAIL': '/var/mail/cltbld', 10:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:54 INFO - 'MOZ_NO_REMOTE': '1', 10:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:54 INFO - 'NO_EM_RESTART': '1', 10:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:54 INFO - 'PWD': '/builds/slave/test', 10:56:54 INFO - 'SHELL': '/bin/bash', 10:56:54 INFO - 'SHLVL': '1', 10:56:54 INFO - 'TERM': 'linux', 10:56:54 INFO - 'TMOUT': '86400', 10:56:54 INFO - 'USER': 'cltbld', 10:56:54 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', 10:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:54 INFO - '_': '/tools/buildbot/bin/python'} 10:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:56:54 INFO - Cleaning up... 10:56:54 INFO - Return code: 0 10:56:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef2a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf320b0>, '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 0xf32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf33440>, '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': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', '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 10:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:56:54 INFO - Using env: {'DISPLAY': ':0', 10:56:54 INFO - 'HOME': '/home/cltbld', 10:56:54 INFO - 'LANG': 'en_US.UTF-8', 10:56:54 INFO - 'LANGUAGE': 'en_US:en', 10:56:54 INFO - 'LOGNAME': 'cltbld', 10:56:54 INFO - 'MAIL': '/var/mail/cltbld', 10:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:54 INFO - 'MOZ_NO_REMOTE': '1', 10:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:54 INFO - 'NO_EM_RESTART': '1', 10:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:54 INFO - 'PWD': '/builds/slave/test', 10:56:54 INFO - 'SHELL': '/bin/bash', 10:56:54 INFO - 'SHLVL': '1', 10:56:54 INFO - 'TERM': 'linux', 10:56:54 INFO - 'TMOUT': '86400', 10:56:54 INFO - 'USER': 'cltbld', 10:56:54 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', 10:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:54 INFO - '_': '/tools/buildbot/bin/python'} 10:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:54 INFO - Downloading/unpacking psutil>=0.7.1 10:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:56:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:56:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:56 INFO - Installing collected packages: psutil 10:56:56 INFO - Running setup.py install for psutil 10:56:56 INFO - building 'psutil._psutil_linux' extension 10:56:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:56:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:56:56 INFO - building 'psutil._psutil_posix' extension 10:56:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:56:57 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 10:56:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:57 INFO - Successfully installed psutil 10:56:57 INFO - Cleaning up... 10:56:57 INFO - Return code: 0 10:56:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef2a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf320b0>, '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 0xf32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf33440>, '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': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', '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 10:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:56:57 INFO - Using env: {'DISPLAY': ':0', 10:56:57 INFO - 'HOME': '/home/cltbld', 10:56:57 INFO - 'LANG': 'en_US.UTF-8', 10:56:57 INFO - 'LANGUAGE': 'en_US:en', 10:56:57 INFO - 'LOGNAME': 'cltbld', 10:56:57 INFO - 'MAIL': '/var/mail/cltbld', 10:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:57 INFO - 'MOZ_NO_REMOTE': '1', 10:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:57 INFO - 'NO_EM_RESTART': '1', 10:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:57 INFO - 'PWD': '/builds/slave/test', 10:56:57 INFO - 'SHELL': '/bin/bash', 10:56:57 INFO - 'SHLVL': '1', 10:56:57 INFO - 'TERM': 'linux', 10:56:57 INFO - 'TMOUT': '86400', 10:56:57 INFO - 'USER': 'cltbld', 10:56:57 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', 10:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:57 INFO - '_': '/tools/buildbot/bin/python'} 10:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:56:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:56:59 INFO - Installing collected packages: mozsystemmonitor 10:56:59 INFO - Running setup.py install for mozsystemmonitor 10:56:59 INFO - Successfully installed mozsystemmonitor 10:56:59 INFO - Cleaning up... 10:56:59 INFO - Return code: 0 10:56:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef2a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf320b0>, '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 0xf32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf33440>, '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': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', '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 10:56:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:56:59 INFO - Using env: {'DISPLAY': ':0', 10:56:59 INFO - 'HOME': '/home/cltbld', 10:56:59 INFO - 'LANG': 'en_US.UTF-8', 10:56:59 INFO - 'LANGUAGE': 'en_US:en', 10:56:59 INFO - 'LOGNAME': 'cltbld', 10:56:59 INFO - 'MAIL': '/var/mail/cltbld', 10:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:59 INFO - 'MOZ_NO_REMOTE': '1', 10:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:59 INFO - 'NO_EM_RESTART': '1', 10:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:59 INFO - 'PWD': '/builds/slave/test', 10:56:59 INFO - 'SHELL': '/bin/bash', 10:56:59 INFO - 'SHLVL': '1', 10:56:59 INFO - 'TERM': 'linux', 10:56:59 INFO - 'TMOUT': '86400', 10:56:59 INFO - 'USER': 'cltbld', 10:56:59 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', 10:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:59 INFO - '_': '/tools/buildbot/bin/python'} 10:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:59 INFO - Downloading/unpacking blobuploader==1.2.4 10:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:01 INFO - Downloading blobuploader-1.2.4.tar.gz 10:57:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:57:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:57:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:01 INFO - Downloading docopt-0.6.1.tar.gz 10:57:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:57:01 INFO - Installing collected packages: blobuploader, requests, docopt 10:57:01 INFO - Running setup.py install for blobuploader 10:57:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:57:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:57:02 INFO - Running setup.py install for requests 10:57:02 INFO - Running setup.py install for docopt 10:57:02 INFO - Successfully installed blobuploader requests docopt 10:57:02 INFO - Cleaning up... 10:57:02 INFO - Return code: 0 10:57:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef2a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf320b0>, '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 0xf32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf33440>, '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': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', '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 10:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:57:02 INFO - Using env: {'DISPLAY': ':0', 10:57:02 INFO - 'HOME': '/home/cltbld', 10:57:02 INFO - 'LANG': 'en_US.UTF-8', 10:57:02 INFO - 'LANGUAGE': 'en_US:en', 10:57:02 INFO - 'LOGNAME': 'cltbld', 10:57:02 INFO - 'MAIL': '/var/mail/cltbld', 10:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:02 INFO - 'MOZ_NO_REMOTE': '1', 10:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:02 INFO - 'NO_EM_RESTART': '1', 10:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:02 INFO - 'PWD': '/builds/slave/test', 10:57:02 INFO - 'SHELL': '/bin/bash', 10:57:02 INFO - 'SHLVL': '1', 10:57:02 INFO - 'TERM': 'linux', 10:57:02 INFO - 'TMOUT': '86400', 10:57:02 INFO - 'USER': 'cltbld', 10:57:02 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', 10:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:02 INFO - '_': '/tools/buildbot/bin/python'} 10:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:02 INFO - Running setup.py (path:/tmp/pip-myxMI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:02 INFO - Running setup.py (path:/tmp/pip-pX98_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:02 INFO - Running setup.py (path:/tmp/pip-rwYFhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:02 INFO - Running setup.py (path:/tmp/pip-NxEnCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:03 INFO - Running setup.py (path:/tmp/pip-bCF2lH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:03 INFO - Running setup.py (path:/tmp/pip-6BkQ51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:03 INFO - Running setup.py (path:/tmp/pip-fnYst6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:03 INFO - Running setup.py (path:/tmp/pip-SqCySD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:03 INFO - Running setup.py (path:/tmp/pip-SZFUpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:03 INFO - Running setup.py (path:/tmp/pip-Jl3g49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:03 INFO - Running setup.py (path:/tmp/pip-HzNpyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:03 INFO - Running setup.py (path:/tmp/pip-OkMCl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:03 INFO - Running setup.py (path:/tmp/pip-c9eoK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:03 INFO - Running setup.py (path:/tmp/pip-6R_DAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:03 INFO - Running setup.py (path:/tmp/pip-NyUaeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:03 INFO - Running setup.py (path:/tmp/pip-ycuMRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:03 INFO - Running setup.py (path:/tmp/pip-9CFVLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:57:03 INFO - Running setup.py install for manifestparser 10:57:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:57:04 INFO - Running setup.py install for mozcrash 10:57:04 INFO - Running setup.py install for mozdebug 10:57:04 INFO - Running setup.py install for mozdevice 10:57:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:57:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:57:04 INFO - Running setup.py install for mozfile 10:57:04 INFO - Running setup.py install for mozhttpd 10:57:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:57:04 INFO - Running setup.py install for mozinfo 10:57:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:57:04 INFO - Running setup.py install for mozInstall 10:57:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:57:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:57:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:57:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:57:04 INFO - Running setup.py install for mozleak 10:57:04 INFO - Running setup.py install for mozlog 10:57:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:57:05 INFO - Running setup.py install for moznetwork 10:57:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:57:05 INFO - Running setup.py install for mozprocess 10:57:05 INFO - Running setup.py install for mozprofile 10:57:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:57:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:57:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:57:05 INFO - Running setup.py install for mozrunner 10:57:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:57:05 INFO - Running setup.py install for mozscreenshot 10:57:05 INFO - Running setup.py install for moztest 10:57:05 INFO - Running setup.py install for mozversion 10:57:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:57:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:57:05 INFO - Cleaning up... 10:57:05 INFO - Return code: 0 10:57:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef2a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf320b0>, '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 0xf32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf33440>, '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': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', '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 10:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:57:05 INFO - Using env: {'DISPLAY': ':0', 10:57:05 INFO - 'HOME': '/home/cltbld', 10:57:05 INFO - 'LANG': 'en_US.UTF-8', 10:57:05 INFO - 'LANGUAGE': 'en_US:en', 10:57:05 INFO - 'LOGNAME': 'cltbld', 10:57:05 INFO - 'MAIL': '/var/mail/cltbld', 10:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:05 INFO - 'MOZ_NO_REMOTE': '1', 10:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:05 INFO - 'NO_EM_RESTART': '1', 10:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:05 INFO - 'PWD': '/builds/slave/test', 10:57:05 INFO - 'SHELL': '/bin/bash', 10:57:05 INFO - 'SHLVL': '1', 10:57:05 INFO - 'TERM': 'linux', 10:57:05 INFO - 'TMOUT': '86400', 10:57:05 INFO - 'USER': 'cltbld', 10:57:05 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', 10:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:05 INFO - '_': '/tools/buildbot/bin/python'} 10:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:05 INFO - Running setup.py (path:/tmp/pip-rXgJdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:06 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)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:06 INFO - Running setup.py (path:/tmp/pip-Th58Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:06 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)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:06 INFO - Running setup.py (path:/tmp/pip-AttFZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:06 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)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:06 INFO - Running setup.py (path:/tmp/pip-D0wJTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:06 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)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:06 INFO - Running setup.py (path:/tmp/pip-LT7t0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:06 INFO - Running setup.py (path:/tmp/pip-zfnObH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:06 INFO - Running setup.py (path:/tmp/pip-yrXdmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:06 INFO - Running setup.py (path:/tmp/pip-c7fILz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:06 INFO - Running setup.py (path:/tmp/pip-R25Zhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:06 INFO - Running setup.py (path:/tmp/pip-Mh0_O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:06 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)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:06 INFO - Running setup.py (path:/tmp/pip-9NaGVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:06 INFO - Running setup.py (path:/tmp/pip-kK90tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:06 INFO - Running setup.py (path:/tmp/pip-jNQZNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:06 INFO - Running setup.py (path:/tmp/pip-IHsHZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:07 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)) 10:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:07 INFO - Running setup.py (path:/tmp/pip-uPzNT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:07 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)) 10:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:07 INFO - Running setup.py (path:/tmp/pip-GYt8KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:07 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)) 10:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:07 INFO - Running setup.py (path:/tmp/pip-lWXcZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:07 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)) 10:57:07 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)) 10:57:07 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)) 10:57:07 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)) 10:57:07 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)) 10:57:07 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)) 10:57:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 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 10:57:07 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 10:57:08 INFO - Downloading blessings-1.5.1.tar.gz 10:57:08 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 10:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:57:08 INFO - Installing collected packages: blessings 10:57:08 INFO - Running setup.py install for blessings 10:57:09 INFO - Successfully installed blessings 10:57:09 INFO - Cleaning up... 10:57:09 INFO - Return code: 0 10:57:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:57:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:09 INFO - Reading from file tmpfile_stdout 10:57:09 INFO - Current package versions: 10:57:09 INFO - argparse == 1.2.1 10:57:09 INFO - blessings == 1.5.1 10:57:09 INFO - blobuploader == 1.2.4 10:57:09 INFO - docopt == 0.6.1 10:57:09 INFO - manifestparser == 1.1 10:57:09 INFO - mozInstall == 1.12 10:57:09 INFO - mozcrash == 0.16 10:57:09 INFO - mozdebug == 0.1 10:57:09 INFO - mozdevice == 0.47 10:57:09 INFO - mozfile == 1.2 10:57:09 INFO - mozhttpd == 0.7 10:57:09 INFO - mozinfo == 0.9 10:57:09 INFO - mozleak == 0.1 10:57:09 INFO - mozlog == 3.1 10:57:09 INFO - moznetwork == 0.27 10:57:09 INFO - mozprocess == 0.22 10:57:09 INFO - mozprofile == 0.27 10:57:09 INFO - mozrunner == 6.11 10:57:09 INFO - mozscreenshot == 0.1 10:57:09 INFO - mozsystemmonitor == 0.0 10:57:09 INFO - moztest == 0.7 10:57:09 INFO - mozversion == 1.4 10:57:09 INFO - psutil == 3.1.1 10:57:09 INFO - requests == 1.2.3 10:57:09 INFO - wsgiref == 0.1.2 10:57:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fef2a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf320b0>, '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 0xf32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf33440>, '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': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', '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 10:57:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 10:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 10:57:09 INFO - Using env: {'DISPLAY': ':0', 10:57:09 INFO - 'HOME': '/home/cltbld', 10:57:09 INFO - 'LANG': 'en_US.UTF-8', 10:57:09 INFO - 'LANGUAGE': 'en_US:en', 10:57:09 INFO - 'LOGNAME': 'cltbld', 10:57:09 INFO - 'MAIL': '/var/mail/cltbld', 10:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:09 INFO - 'MOZ_NO_REMOTE': '1', 10:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:09 INFO - 'NO_EM_RESTART': '1', 10:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:09 INFO - 'PWD': '/builds/slave/test', 10:57:09 INFO - 'SHELL': '/bin/bash', 10:57:09 INFO - 'SHLVL': '1', 10:57:09 INFO - 'TERM': 'linux', 10:57:09 INFO - 'TMOUT': '86400', 10:57:09 INFO - 'USER': 'cltbld', 10:57:09 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', 10:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:09 INFO - '_': '/tools/buildbot/bin/python'} 10:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:57:09 INFO - Cleaning up... 10:57:09 INFO - Return code: 0 10:57:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fef2a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf320b0>, '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 0xf32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf33440>, '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': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', '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 10:57:09 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 10:57:09 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 10:57:09 INFO - Using env: {'DISPLAY': ':0', 10:57:09 INFO - 'HOME': '/home/cltbld', 10:57:09 INFO - 'LANG': 'en_US.UTF-8', 10:57:09 INFO - 'LANGUAGE': 'en_US:en', 10:57:09 INFO - 'LOGNAME': 'cltbld', 10:57:09 INFO - 'MAIL': '/var/mail/cltbld', 10:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:09 INFO - 'MOZ_NO_REMOTE': '1', 10:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:09 INFO - 'NO_EM_RESTART': '1', 10:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:09 INFO - 'PWD': '/builds/slave/test', 10:57:09 INFO - 'SHELL': '/bin/bash', 10:57:09 INFO - 'SHLVL': '1', 10:57:09 INFO - 'TERM': 'linux', 10:57:09 INFO - 'TMOUT': '86400', 10:57:09 INFO - 'USER': 'cltbld', 10:57:09 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', 10:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:09 INFO - '_': '/tools/buildbot/bin/python'} 10:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:09 INFO - Downloading/unpacking jsonschema 10:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:57:11 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 10:57:11 INFO - Downloading/unpacking functools32 (from jsonschema) 10:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:11 INFO - Downloading functools32-3.2.3-2.tar.gz 10:57:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:57:11 INFO - warning: no files found matching '*.txt' 10:57:11 INFO - no previously-included directories found matching 'build' 10:57:11 INFO - no previously-included directories found matching 'dist' 10:57:11 INFO - no previously-included directories found matching '.git*' 10:57:11 INFO - Installing collected packages: jsonschema, functools32 10:57:11 INFO - Running setup.py install for functools32 10:57:11 INFO - warning: no files found matching '*.txt' 10:57:11 INFO - no previously-included directories found matching 'build' 10:57:11 INFO - no previously-included directories found matching 'dist' 10:57:11 INFO - no previously-included directories found matching '.git*' 10:57:11 INFO - Successfully installed jsonschema functools32 10:57:11 INFO - Cleaning up... 10:57:11 INFO - Return code: 0 10:57:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fef2a082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea3240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf320b0>, '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 0xf32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf33440>, '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': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', '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 10:57:11 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 10:57:11 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 10:57:11 INFO - Using env: {'DISPLAY': ':0', 10:57:11 INFO - 'HOME': '/home/cltbld', 10:57:11 INFO - 'LANG': 'en_US.UTF-8', 10:57:11 INFO - 'LANGUAGE': 'en_US:en', 10:57:11 INFO - 'LOGNAME': 'cltbld', 10:57:11 INFO - 'MAIL': '/var/mail/cltbld', 10:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:11 INFO - 'MOZ_NO_REMOTE': '1', 10:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:11 INFO - 'NO_EM_RESTART': '1', 10:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:11 INFO - 'PWD': '/builds/slave/test', 10:57:11 INFO - 'SHELL': '/bin/bash', 10:57:11 INFO - 'SHLVL': '1', 10:57:11 INFO - 'TERM': 'linux', 10:57:11 INFO - 'TMOUT': '86400', 10:57:11 INFO - 'USER': 'cltbld', 10:57:11 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', 10:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:11 INFO - '_': '/tools/buildbot/bin/python'} 10:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:12 INFO - Downloading/unpacking flake8 10:57:12 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 10:57:12 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 10:57:12 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 10:57:12 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 10:57:12 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 10:57:12 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 10:57:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:57:13 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 10:57:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:57:14 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 10:57:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:57:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:14 INFO - no previously-included directories found matching 'docs/_build' 10:57:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:57:14 INFO - Running setup.py install for pep8 10:57:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:14 INFO - no previously-included directories found matching 'docs/_build' 10:57:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:57:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:57:14 INFO - Cleaning up... 10:57:14 INFO - Return code: 0 10:57:14 INFO - Running post-action listener: _resource_record_post_action 10:57:14 INFO - Running post-action listener: _start_resource_monitoring 10:57:14 INFO - Starting resource monitoring. 10:57:14 INFO - ##### 10:57:14 INFO - ##### Running install step. 10:57:14 INFO - ##### 10:57:14 INFO - Running pre-action listener: _resource_record_pre_action 10:57:14 INFO - Running main action method: install 10:57:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:14 INFO - Reading from file tmpfile_stdout 10:57:14 INFO - Detecting whether we're running mozinstall >=1.0... 10:57:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:57:15 INFO - Reading from file tmpfile_stdout 10:57:15 INFO - Output received: 10:57:15 INFO - Usage: mozinstall [options] installer 10:57:15 INFO - Options: 10:57:15 INFO - -h, --help show this help message and exit 10:57:15 INFO - -d DEST, --destination=DEST 10:57:15 INFO - Directory to install application into. [default: 10:57:15 INFO - "/builds/slave/test"] 10:57:15 INFO - --app=APP Application being installed. [default: firefox] 10:57:15 INFO - mkdir: /builds/slave/test/build/application 10:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:57:29 INFO - Reading from file tmpfile_stdout 10:57:29 INFO - Output received: 10:57:29 INFO - /builds/slave/test/build/application/firefox/firefox 10:57:29 INFO - Running post-action listener: _resource_record_post_action 10:57:29 INFO - ##### 10:57:29 INFO - ##### Running run-tests step. 10:57:29 INFO - ##### 10:57:29 INFO - Running pre-action listener: _resource_record_pre_action 10:57:29 INFO - Running main action method: run_tests 10:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:57:29 INFO - Python 2.7.3 10:57:29 INFO - Return code: 0 10:57:29 INFO - grabbing minidump binary from tooltool 10:57:29 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')]} 10:57:29 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 0xf320b0>, '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 0xf32fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf33440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:57:29 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 10:57:29 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 10:57:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:57:29 INFO - Return code: 0 10:57:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:57:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:57:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:57:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:57:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:57:30 INFO - Return code: 0 10:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] in /builds/slave/test/build 10:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost 10:57:30 INFO - Using env: {'DISPLAY': ':0', 10:57:30 INFO - 'HOME': '/home/cltbld', 10:57:30 INFO - 'LANG': 'en_US.UTF-8', 10:57:30 INFO - 'LANGUAGE': 'en_US:en', 10:57:30 INFO - 'LOGNAME': 'cltbld', 10:57:30 INFO - 'MAIL': '/var/mail/cltbld', 10:57:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:57:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:30 INFO - 'MOZ_NO_REMOTE': '1', 10:57:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:30 INFO - 'NO_EM_RESTART': '1', 10:57:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:30 INFO - 'PWD': '/builds/slave/test', 10:57:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:57:30 INFO - 'SHELL': '/bin/bash', 10:57:30 INFO - 'SHLVL': '1', 10:57:30 INFO - 'TERM': 'linux', 10:57:30 INFO - 'TMOUT': '86400', 10:57:30 INFO - 'USER': 'cltbld', 10:57:30 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916', 10:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:30 INFO - '_': '/tools/buildbot/bin/python'} 10:57:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] with output_timeout 3600 10:57:30 INFO - mozversion INFO | application_buildid: 20151216101138 10:57:30 INFO - mozversion INFO | application_changeset: e735b7607ae25e5769d49fb848292d56889330fe 10:57:30 INFO - mozversion INFO | application_display_name: Nightly 10:57:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:57:30 INFO - mozversion INFO | application_name: Firefox 10:57:30 INFO - mozversion INFO | application_remotingname: firefox 10:57:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:57:30 INFO - mozversion INFO | application_vendor: Mozilla 10:57:30 INFO - mozversion INFO | application_version: 46.0a1 10:57:30 INFO - mozversion INFO | platform_buildid: 20151216101138 10:57:30 INFO - mozversion INFO | platform_changeset: e735b7607ae25e5769d49fb848292d56889330fe 10:57:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:57:30 INFO - mozversion INFO | platform_version: 46.0a1 10:57:30 INFO - 2015-12-16 10:57:30,779 DEBUG : using testdate: 1450292250 10:57:30 INFO - 2015-12-16 10:57:30,779 DEBUG : actual date: 1450292250 10:57:30 INFO - 2015-12-16 10:57:30,789 INFO : starting webserver on 'localhost:42086' 10:57:30 INFO - 2015-12-16 10:57:30,790 INFO : Starting test suite talos-linux64-ix-018.e 10:57:30 INFO - 2015-12-16 10:57:30,790 INFO : Starting test dromaeo_css 10:57:30 INFO - 2015-12-16 10:57:30,790 DEBUG : operating with platform_type : linux_ 10:57:30 INFO - 2015-12-16 10:57:30,790 INFO : Initialising browser for dromaeo_css test... 10:57:30 INFO - 2015-12-16 10:57:30,803 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8celh8/profile http://localhost:42086/getInfo.html 10:57:35 INFO - 2015-12-16 10:57:35,301 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:57:35 INFO - 2015-12-16 10:57:35,301 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:57:35 INFO - 2015-12-16 10:57:35,301 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:57:35 INFO - 2015-12-16 10:57:35,301 DEBUG : BROWSER_OUTPUT: __metrics 10:57:35 INFO - 2015-12-16 10:57:35,409 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] 10:57:36 INFO - 2015-12-16 10:57:36,532 INFO : Browser initialized. 10:57:36 INFO - 2015-12-16 10:57:36,533 INFO : Running cycle 1/1 for dromaeo_css test... 10:57:36 INFO - 2015-12-16 10:57:36,533 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8celh8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:57:48 INFO - 2015-12-16 10:57:48,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 143245312 10:57:48 INFO - 2015-12-16 10:57:48,530 DEBUG : BROWSER_OUTPUT: 10:58:38 INFO - 2015-12-16 10:58:38,157 DEBUG : BROWSER_OUTPUT: 1450292318155 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] 11:00:50 INFO - 2015-12-16 11:00:50,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42086/tests/dromaeo/cssquery-ext.html) 11:00:51 INFO - 2015-12-16 11:00:51,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 147226624 11:00:51 INFO - 2015-12-16 11:00:51,030 DEBUG : BROWSER_OUTPUT: 11:03:52 INFO - 2015-12-16 11:03:52,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/dromaeo/cssquery-ext.html (next: http://localhost:42086/tests/dromaeo/cssquery-jquery.html) 11:03:53 INFO - 2015-12-16 11:03:53,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 143953920 11:03:53 INFO - 2015-12-16 11:03:53,484 DEBUG : BROWSER_OUTPUT: 11:06:55 INFO - 2015-12-16 11:06:55,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42086/tests/dromaeo/cssquery-mootools.html) 11:06:55 INFO - 2015-12-16 11:06:55,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 146194432 11:06:55 INFO - 2015-12-16 11:06:55,825 DEBUG : BROWSER_OUTPUT: 11:09:57 INFO - 2015-12-16 11:09:57,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42086/tests/dromaeo/cssquery-prototype.html) 11:09:58 INFO - 2015-12-16 11:09:58,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 143196160 11:09:58 INFO - 2015-12-16 11:09:58,159 DEBUG : BROWSER_OUTPUT: 11:13:00 INFO - 2015-12-16 11:13:00,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42086/tests/dromaeo/cssquery-yui.html) 11:13:01 INFO - 2015-12-16 11:13:01,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 144646144 11:13:01 INFO - 2015-12-16 11:13:01,365 DEBUG : BROWSER_OUTPUT: 11:16:03 INFO - 2015-12-16 11:16:03,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/dromaeo/cssquery-yui.html (next: http://localhost:42086/tests/dromaeo/cssquery-dojo.html) 11:16:04 INFO - 2015-12-16 11:16:04,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 148348928 11:16:04 INFO - 2015-12-16 11:16:04,081 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-12-16 11:16:04,081 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:16:04 INFO - 2015-12-16 11:16:04,081 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:16:04 INFO - 2015-12-16 11:16:04,081 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:16:04 INFO - 2015-12-16 11:16:04,081 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:16:04 INFO - 2015-12-16 11:16:04,083 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2682.9463410731787;2711.7288271172897;2744.492268930248;2761.406297646007;2770.0443347045275;4676.1349150407195;4773.761311934402;4807.759612019402;4810.06203790261;4876.658633895629;4707.78814953327;4723.976380118103;4728.834490792823;4744.1934871072;4750;4413.514513403523;4448.688591798567;4494;4505.144022635705;4514.322851572274;4416.470023597173;4453.955460445386;4454.955450445486;4462.486814016397;4494.752788596642;4241.172971270604;4359.280718681413;4452.243118669801;4471;4501.324801279818;4432.689711720181;4448.3549885266775;4454.265046267362;4458.286674132156;4486.371907932892;4256.4679415073115;4427.557244275579;4436.534163912807;4473.5526447355005;4475.4181956345465;4590.311453282001;4603.953960460386;4712.057588482283;4731.148393289207;4772.260299653559;5077.238414237857;5127.743612819344;5129.563987061104;5133.563647090002;5178.508041736029;4904.386951631046;5151.124308867502;5159.793608255665;5163.845084647466;5173.068847607429;4665.2768820832825;4722.055588882237;4776.2119250324;4801.5438533339275;4846.927296090562;5230.581553475713;5235.267062611238;5237.5286224239235;5273.709945953009;5278.181881808326;4806.134895718735;4880.267959806058;5031.245313203049;5036.471170527042;5037.471065538066;5093.719845408538;5115.283860259567;5131.666441681354;5149.948500515022;5189.844304670866;5094.719790411563;5106.540411362995;5112.539871411516;5118.38579370478;5139.948600513947;4818.373611430492;4931.630127740362;4959.80964568501;5052;5075;4243.936340954888;4255.97872010638;4283.721558098714;4299.097189590221;4333.328334108218;3733.253349330145;3745.3632882410056;3762.9623703762613;3763.7553559018575;3802.5817160112365;4292.892677683083;4361.345798130305;4375.606195442426;4453.3320001999955;4460.375547423363;5127.97436012825;5139.177731562932;5140.742962851918;5160.174372100446;5177.870553236124;4412.911741765147;4427.26950053244;4431.468223813163;4442.8222871085445;4498.212812757754;4408.228560001987;4454.977725111418;4505;4524.705894116872;4549.044700612908;4876.292937524039;4909.5090490950615;4911.926321105115;4913.656044076952;4944.01119776039;4919.581835543876;5134.460881607378;5180.222966555047;5190.325217842171;5223.791048358175;4806.807727690853;4824.445188803192;4900.656954013185;4907.2393778964315;4933.876653083558;5074.594032477319;5100.285959965682;5112.463191364853;5118.181091025418;5148.613853961043;4942.233953737176;5060.342155519759;5170.663906846043;5186.8962620746615;5186.948130518646;4895.926561101515;4941.184704523714;4946.258061290835;4966.354373931365;5027;4939.357883475269;4978.2034874419915;5017.272495488207;5018.924716129188;5050.898982020265;4710.552497512731;4856.053069651384;4902.362692849907;4915.410150781929;4954.727489988085;4983;5033.697978121324;5038.2190760432195;5038.773255203598;5068.569171620306;4913.410390753133;4953.331300274417;4958.256261560795;4961.454240033521;5018.4730603286125 11:16:04 INFO - 2015-12-16 11:16:04,084 DEBUG : BROWSER_OUTPUT: |1;ext.html;528.9841304760859;555.6249531566192;570.9571782116342;576.9653820770754;590.7666471743659;26419.339516512096;36010.63989360109;36173.45739813905;36225.275494490095;36388.45417318743;38866.41700374489;39387.80306098473;39448;39467.605323946824;39602.207955840866;7639.204786875094;7776.339011184056;7787.493812902171;7801.609919504031;7830.29527342539;7790.688372465094;7795.298423141916;7894.802629934269;7900.64447099879;7913.406494512935;7722.459427840054;7760.689572417096;7819.569923654197;7823.374130069609;7845.058592968823;7847.843043139133;7856.72501462449;7912.525248485109;7917.762467126025;7921.36629069673;7758.922410775876;7888.368930485547;7889.092754333267;7891.9605401973195;7909.564973926432;37161.62838371609;37311.440328395096;37672;37712.43431348504;37776.244475110616;2875.180573536553;2884.6538415390287;2938.5885975963383;2956.482615542293;3523.94714079289;28047.71952280492;28212.435751285066;28236.85881570579;28272.15183544497;28321.716782832114;3237.676232376767;3302.9009129725905;3324.4514655081884;3378.3074469733647;3398.5411969384063;212712;213952;213953;214470;214830;53236.46763532393;53662;57275.71362143246;63492;65101.34898651048;55612.72193639006;55711;55753.44246557564;55783;55993.16010259849;13403.396847141901;13413.530526431528;13428;13430.328483575977;13449.663758406117;10394.584216631401;10415.94792026035;10440.63457778974;10487.895121048692;10507.842382364272;19482.707759383622;19611.313604024075;19778;19829.504262393555;19833;7686.500377475446;7844.37245020397;7921.762347129596;7930.0880398753725;7938.206179382016;909.1181553892714;954.3367359684952;965.6282331302499;974.7319487140951;1076.5263284154946;26306.86846565755;26577.069802556816;26622.6006609901;26638.866805665846;26764.732352676612;978.2467500024941;996.2602842183994;1038.4548112241134;1060.1201003167353;1088.9328458110938;13630.1140425872;13856.237906915016;13906;14101.083429577046;14222.146671199762;263576;266729.666351667;267216;268465;268627;45796.54203457989;46312.5368746315;46371;46510.76744616323;46668.7666561665;1220.3166226912956;1224.9020078393708;1227.8281040654315;1241.4351470081272;1246.4640204712061;25458.618120727835;26324.605130922668;26529;26745.197644070708;26921.596176057767;42716.145677086904;43263.35104973365;43391.13217735691;43405.914852128946;43473.56526434695;238978;242838;243486;244214;244627;38707.225855483295;43347.133057339306;43354.349684754125;43738.56261437345;44369.778151109036;38824.223515530095;38909.61090389173;39153.21693566056;39726.801365992986;39924.40113398359;32672;33108.503372449915;33341.33317333688;33392.33215335728;33556.664433355356;32667;33051.66948330582;33108.337833243684;33131.83434082814;33143.66856331406;32596.185095372806;33590.664093358755;33625.32749345048;33634.327313453105;33673;28763.45025589814;30694;30822.075337739905;30840.94425313153;30913.72333516493;23467.647985280575;23535.646965295877;23771.881140594185;23906.52186956286;23954 11:16:04 INFO - 2015-12-16 11:16:04,085 DEBUG : BROWSER_OUTPUT: |2;jquery.html;338.4060972992398;340.4314794293531;340.51306631516934;340.76146697311856;342.525602041173;14521.491747788816;14688.853111468881;15764.605884852885;16290.10404427756;16916.91541542292;9701.708948731532;9730.367526110798;9875.851862222073;9944.701658950225;9992.750181245472;4348.239058164824;4476.171908196978;4478.0596074824325;4482.529334419888;4506.639468842484;4431.534688857671;4454.621357184643;4765.356676848615;4983.327250821148;4984.501549845005;4811.518848115195;4945.282933974571;4946.356973593428;4954.628402869781;4968.950310496885;5693.914591281134;5737.88524229513;5738.254026976508;5753.050746626823;5753.971230143843;4992.6005919526715;5090.160123579605;5096.210087436416;5097.23541468779;5116.309298244727;10795.784084318348;10916.181286403473;10929.617463388822;10965.890341096567;11009.174311926557;1722.1303241862904;1762.488878225313;1778.457570441015;1854.249029143199;1948.2401863273335;8503.702370417006;8557.22984931353;9421.62313507459;9725.951370243174;12146.5748698796;1742.3466200174935;1747.571844898008;1750.422360620992;1769.4780039888265;1775.5472354549636;48615.27077093846;53046.734766326306;55332;56917.14624280639;58309;8953.328500362499;9342.159205671522;9633.277504187214;9663;9670.323077384515;11919.821202681967;12060.758784824255;12069.396530173632;12153.93923030397;12317.260964342167;6971.930280697229;7149.106361704787;7190.64046797658;7245.275472452818;7283.817904552428;7051.858962820715;7068.187158476738;7080.114985626797;7114.217436082027;7124.821879453055;4155.729877557949;4249.957500424956;4253.893652658709;4258.446401967724;4263.211305908417;1610.1385758619317;1646.6048148444288;1656.7100757367411;1662.4098445052075;1674.7320428731346;862.2756884217288;883.1874675298741;911.8495448250965;914.3736540469666;926.754410081329;15151.393944242327;15670.561164779008;15811.209439527978;15818.683626327409;15958.601034973986;758.4122305213393;836.6820608168857;855.2473823035689;861.0442408926087;877.8727084572702;8060.153683863227;8262.545559994258;8427.915720842713;8562.48625082497;8583.442076265022;319065;319979;320022;323043;324492;65636;67471;68975.31024689789;72086;77899.2210077892;439.973601583906;452.38927447945014;452.4321975920199;452.4886877828033;454.9317602359606;9308.627654893728;9368.203702685349;9449.622015119317;9661.323707340418;9724.465154416575;28792;31313.530297046018;31474;33045.17387065342;33742.49386259257;35081.82459087688;35664.64335356717;36504.63495365012;38130;39285;8531.573421328785;8607.741767746978;8727.476351418934;8737.169968852948;8740;10883.619073332395;15618.062916225063;15841.603959901095;15985.280662370455;16133.677326453171;13257.53598624082;13513.459461621425;13750;13933.930330348283;14069.226192559097;13407.798883016567;13626.659333516345;13930.58208253754;13989.300534973007;14151.221682807545;14022.579322620337;14147.36336864823;14281.357338919981;14495.347709353315;14778.261086945824;8951.060138685605;9009.099090090938;9160.221381182673;9292.210162136023;9306.208972237435;9458.101480359355;11911.463984120563;13170.934145329595;13659.658508537366;14184.148951062969 11:16:04 INFO - 2015-12-16 11:16:04,087 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1485.814273215848;1637.4105322084047;1637.9344826206952;1671.6990941630506;1770;7114.501984861049;7145.5355401898905;7169.498135130543;7385.7414990475345;7423.2205618410035;7399.445041621886;7431.5169513981555;7465.626718664059;7480.625968701556;7480.925190748091;2118.8834614096218;2139.967900481494;2145.9892700536475;2154.353693891834;2160.503084290614;2078.490769761411;2097.979020209794;2099.2862426774896;2134.359692092366;2172.2071443923014;2070.492729281321;2080.7503099628066;2081.0739221046642;2116.2275769344233;2116.238154264471;2103.6949642301856;2111.2505060703384;2128.3402145334917;2132.4775430019745;2132.8826914519773;2049.3358633776033;2108;2113.8837363944976;2119.98940005299;2120.289702949514;7264.273572642746;7343.3758130558435;7347;7350.264973502661;7364.153122390887;4214.536400995888;4260.850870219528;4279.550647182064;4279.764612946286;4280.5719428057255;2854.2293580733085;2858.9142325730263;2925.312551550384;2932.0470846974818;2934.0464349086633;835.1815221083311;837.9664813407456;864.930805535562;867.418829384314;916.0427353415697;9677.661281855171;9806.117449429514;9811.90188098117;9819.459929703935;9821;3803.1442925341576;3803.372443546784;3865.9226815463535;3871.380579107329;3880.1851611161974;8037.23646253605;8078.39412044099;8086.1913808618665;8088.11030786613;8114.797130071795;4271.615554600101;4272.6154646082;4273.87178384649;4274.935875961863;4279.593438623326;3207.4386982278006;3297.225152089257;3790.469334293201;3882.825272862728;3921.784301863368;3223.564818749439;3232.466643003925;3251;3266.4283750343593;3273.607167139911;961.0725649748026;982.2878413150409;982.4694664880884;986.5363279258737;987.4322264697684;1158.9188756787112;1181.4919584578543;1195.2708847602955;1209.0629761934395;1211.5335595795507;6709.29552397001;6723.529352945345;6792.252852186256;6864.141982252218;6874.65626718662;428.6270944278498;429.66271476891114;430.9353596960481;437.36145227966887;438.49353996134516;5431.53831924283;5470.9452905471235;5471.261379713687;5506.862328441741;5509.696966666872;8039.5176289422825;8312.5428101455;8355.582220888931;8404.957975210085;8680.956595216983;8309.459885107448;8364.163583641588;8393.118722534167;8396.622152003174;8473.618687159093;6830.419414349736;6848.246692863781;6950;6955.408790252784;6979.371856532936;6829.4877884157895;6863.931360686329;6884.690188941409;6886.621235832077;6887.311268873073;7682.116556595839;7722.6138693063995;7861.331786798186;7872.606369681607;7885.408594355561;7927.84144317122;8022.638981245741;8069.838603227785;8114.5942702865805;8148.551829649189;5445.891082178255;5559.9444005561045;6470.644114573555;6557.049227862029;6604.075429439787;6775.525713200029;6796.796096117125;6830.726770929107;6839.487038472234;6867.381935625817;6007.219061521974;6326.3041065483685;6340.175777149126;6498.187726534184;6616.4045235929;6303.936960630518;6336.714847831767;6392.360763923571;6430.292667806444;6563.9343606563325;6549.4760419167305;6583.934160658332;6593.175853018372;6607.9669601651685;6618.7352505899225;6002.759889604367;6119.204503414528;6125.632462052291;6180.412860778219;6193.473554747717;5923.644581324962;5933.05071188625;5946.108083787293;5948.910766338422;5960.850978725566 11:16:04 INFO - 2015-12-16 11:16:04,088 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.5669865298012;308.5033096714291;308.8517511594433;309.793986998646;312.20076603894046;5581;5589.27339445872;5623.156526521024;5782.421757824221;5802.535797136229;5569.164625306206;5602.047651899176;5628.605997580171;5635.887282254363;5644.350899646532;4143.254214241435;4259.616634502894;4289.785510724467;4301.849435269766;4304.612584867361;4221.113566151112;4252.14957008598;4255.255330317182;4256.787160641971;4280.743155410685;4237.872863814075;4249.426327445802;4249.4475718156755;4250.893727656818;4253.532111467736;4242.97878510607;4248.874048377167;4261.403403523509;4272.423222864904;4273.166732487166;3568.536090308269;3702.500162478085;3703.7222208334215;3704.462852886343;3708.87018954338;5240.580753539708;5388.649737767072;5397.7031263280505;5399.757010934478;5429.647072940246;4887.3890763654545;4902.730349830758;4906.288588154734;4908.460069392364;4912.778924948386;5844.766209351621;5855.355910849803;5861.912071318934;5903.114532820111;5905;3905.511811023622;4026.2148880968225;4027.0536423940353;4033.7983100845136;4074.327735923569;6159.168512250879;6221.097940798559;6238.407351301665;6239.001759718423;6242.1261023456755;4111.93089796655;4116.58834116592;4133.111381053088;4134.028503301722;4137.565555616678;4199.958000420018;4203.159368126387;4207.663386929038;4211.957880421218;4212.831486740557;4735.266033764772;4844.031193761261;4856.465788763233;4865.172920603435;4906.460289368167;5849.385814489502;5853.853653658693;5858.355580886099;5858.47273745365;5882.588218824641;1442.3725679329525;1468.8310844253049;1469.808924839764;1473.0425223604743;1474.4618214351685;978.6427953796955;990.2919412620012;998.6205242007991;1007.5113569918584;1011.7318910488726;5126.794928202905;5137.2037334213255;5140.228965655182;5150.536451719363;5164.251183578435;6109.266887973472;6109.450149486479;6112.113743507167;6122.806052819657;6136.815895523141;5120.61595380348;5131.820386286462;5131.846044618667;5139.22911563261;5149.819756308511;3255.1497872887167;3293.555370025064;3310.668933106718;3328.1346849818738;3331.60020797501;5714.542836573148;5749.88500229993;5779.24869766936;5788;5846.064629659234;6340.778072767431;6364.268109167412;6370.076338930921;6380.138681278061;6382.329855365213;5788.88422231553;5837.3870743571315;5839.124131380327;5841.766329346863;5852.561057920673;6008.188894499362;6120.663363515049;6121.3572574879;6147.231596050494;6163.260408750979;6057.4851137653795;6057.606255593372;6065.2418447694035;6065.696715164312;6069.484093852072;5843.29880414353;5846.064629659234;5854.502367298827;5857.707114644166;5858.531317494675;4144.150449157855;4180.310248808913;4180.728252663567;4182.9581704182565;4187.664986800988;6033.87932241344;6175.3515880831865;6181.072839074175;6190.350013248724;6190.597611155261;5889.087191485327;5917.082852157922;5918.585699001201;5925.259342582177;5929.258842644669;5925.229720136354;5938.851528711644;5941.287045554561;5947.791827286024;5970.820875373745;5631;5760.1935728998815;5783.624064435799;5812.041013232769;5818.185454036523;5980.222571065734;5986.2517185351835;5991.011483105239;5992.700364981821;5995.16067750524;5820.76716931318;5826.766929322949;5844.883102338014;5845.269341332333;5857.619254748428 11:16:04 INFO - 2015-12-16 11:16:04,088 DEBUG : BROWSER_OUTPUT: |5;yui.html;661.5898143151245;720.8270015196352;767.7197822794682;773.5397438524079;781.1212386065677;11662.358570278631;11791.823122653168;11800.232984855978;11841.348725820088;11866.228695134821;11455.541778328878;11795.056395488362;11804.527818887234;11832.112591555624;11837.46731397087;804.3042768005677;820.8030072782519;822.8436597046572;823.3948048184579;841.7180244618061;818.2717381530442;819.397742659145;820.6143112737004;821.2362502872327;827.383599218583;861.3281640320529;862.1249431826701;864.6368525219423;869.9217070463657;870.9520976346298;855.247382303572;860.0281681699639;862.784303924019;863.5380071661663;864.7794812322818;630.136712703599;641.0896526931768;641.5669423139362;641.8555824939398;642.097852517214;12258.264504129691;12317.630471085882;12329.753404931851;12397.62807115788;12413.131080824345;10970.341779493256;11166.050885674646;11168.106551475863;11241.494132764044;11413.086953043736;9458.9527052365;9476.573554190078;9482.431054136774;9591.088846559636;9612.951935240279;3126.444092203277;3185.1877771168433;3219.0664707234873;3240.91897702557;3242.0760083376126;40166.397504037464;40635.593644063476;40638.59361406407;40667.7966610168;40774.184516309804;9060;9164.358494905293;9175;9218.492982885871;9459.24326053914;15268;15330.463433779763;15368.538943831703;15858;15969.36122555108;5862.736176872051;5971.4327138921735;5980.282366116094;6009.489193418521;6202.131701561785;3480;3518.665726755954;3527.2416430467574;3530.5763308402643;3596.9100772480897;2548.4011257354505;2550.9107181248937;2554.476332351863;2556.258684981372;2563.3335332813604;476.41401076675885;476.9546893045155;478.4187212536784;492.4386199732308;494.71801073387826;468.88746700791563;487.27152906404444;576.3602401334515;576.7375843991058;597.1460811040254;7515.736949206752;7558.962205188939;7625.779875219938;7698.692052317844;7750.651220695082;499.1439680947193;536.4849744245568;610.716017052073;625.5902383938527;628.9716962736687;3669.3395188865725;3942.8619998299923;3975.1453437511072;4001.459802926626;4080.489938757655;45999;46148.30777538339;46844.297335539995;47140.76429617898;47177.29234061492;41919.79040104841;43064.569354306055;43114.353284700126;43167.35248971268;43389;39141.60858391436;39445;39580;40616.39075413871;40774.1845163101;7650.076680604062;7872.685092596232;7971.920280797118;8053.476524025919;8117.756467305991;29277.41445171042;30058.69941300559;30147.849260753555;30174.84912575423;32153.196170094998;37408;37562.436563451025;38073.619263807006;38582.80708596439;39222.60777392304;9575.521223938636;9850.655227067018;10188.89811101909;10194.184465242912;10542.894571054192;11041.00630943219;11048.392338421463;11170.609028683957;11494.425278736197;12025.218360806519;10608.257421980386;10730.463476825971;10996.780064398827;11138.164637652046;11457.770844583229;10482;10567.682969510926;10568.630097946534;11067.833982490109;11209.49557269941;9776.511174441392;10433.58265669395;10489.685309440729;10514.894851051391;11001.339919604528;9026.503542305236;9037.638494460149;9134.497602631918;9296.349255552046;9398.812023759623;8900.955495222483;9012.324075694218;9154.221891139328;9317.39436936597;9474 11:16:04 INFO - 2015-12-16 11:16:04,088 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:16:04 INFO - 2015-12-16 11:16:04,088 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:16:04 INFO - 2015-12-16 11:16:04,088 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,328 11:16:04 INFO - 2015-12-16 11:16:04,088 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:16:04 INFO - 2015-12-16 11:16:04,088 DEBUG : BROWSER_OUTPUT: __startTimestamp1450293364080__endTimestamp 11:16:04 INFO - 2015-12-16 11:16:04,088 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-12-16 11:16:04,089 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:16:04 INFO - 2015-12-16 11:16:04,089 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:16:04 INFO - 2015-12-16 11:16:04,089 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-12-16 11:16:04,089 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4728.44 Median:4880.27 stddev:490.10 (10.0%) stddev-sans-first:464.60 11:16:04 INFO - 2015-12-16 11:16:04,090 DEBUG : BROWSER_OUTPUT: Values: 2682.9 2711.7 2744.5 2761.4 2770.0 4676.1 4773.8 4807.8 4810.1 4876.7 4707.8 4724.0 4728.8 4744.2 4750.0 4413.5 4448.7 4494.0 4505.1 4514.3 4416.5 4454.0 4455.0 4462.5 4494.8 4241.2 4359.3 4452.2 4471.0 4501.3 4432.7 4448.4 4454.3 4458.3 4486.4 4256.5 4427.6 4436.5 4473.6 4475.4 4590.3 4604.0 4712.1 4731.1 4772.3 5077.2 5127.7 5129.6 5133.6 5178.5 4904.4 5151.1 5159.8 5163.8 5173.1 4665.3 4722.1 4776.2 4801.5 4846.9 5230.6 5235.3 5237.5 5273.7 5278.2 4806.1 4880.3 5031.2 5036.5 5037.5 5093.7 5115.3 5131.7 5149.9 5189.8 5094.7 5106.5 5112.5 5118.4 5139.9 4818.4 4931.6 4959.8 5052.0 5075.0 4243.9 4256.0 4283.7 4299.1 4333.3 3733.3 3745.4 3763.0 3763.8 3802.6 4292.9 4361.3 4375.6 4453.3 4460.4 5128.0 5139.2 5140.7 5160.2 5177.9 4412.9 4427.3 4431.5 4442.8 4498.2 4408.2 4455.0 4505.0 4524.7 4549.0 4876.3 4909.5 4911.9 4913.7 4944.0 4919.6 5134.5 5180.2 5190.3 5223.8 4806.8 4824.4 4900.7 4907.2 4933.9 5074.6 5100.3 5112.5 5118.2 5148.6 4942.2 5060.3 5170.7 5186.9 5186.9 4895.9 4941.2 4946.3 4966.4 5027.0 4939.4 4978.2 5017.3 5018.9 5050.9 4710.6 4856.1 4902.4 4915.4 4954.7 4983.0 5033.7 5038.2 5038.8 5068.6 4913.4 4953.3 4958.3 4961.5 5018.5 11:16:04 INFO - 2015-12-16 11:16:04,090 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-12-16 11:16:04,090 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40847.28 Median:33653.66 stddev:63048.12 (187.3%) stddev-sans-first:63152.31 11:16:04 INFO - 2015-12-16 11:16:04,090 DEBUG : BROWSER_OUTPUT: Values: 529.0 555.6 571.0 577.0 590.8 26419.3 36010.6 36173.5 36225.3 36388.5 38866.4 39387.8 39448.0 39467.6 39602.2 7639.2 7776.3 7787.5 7801.6 7830.3 7790.7 7795.3 7894.8 7900.6 7913.4 7722.5 7760.7 7819.6 7823.4 7845.1 7847.8 7856.7 7912.5 7917.8 7921.4 7758.9 7888.4 7889.1 7892.0 7909.6 37161.6 37311.4 37672.0 37712.4 37776.2 2875.2 2884.7 2938.6 2956.5 3523.9 28047.7 28212.4 28236.9 28272.2 28321.7 3237.7 3302.9 3324.5 3378.3 3398.5 212712.0 213952.0 213953.0 214470.0 214830.0 53236.5 53662.0 57275.7 63492.0 65101.3 55612.7 55711.0 55753.4 55783.0 55993.2 13403.4 13413.5 13428.0 13430.3 13449.7 10394.6 10415.9 10440.6 10487.9 10507.8 19482.7 19611.3 19778.0 19829.5 19833.0 7686.5 7844.4 7921.8 7930.1 7938.2 909.1 954.3 965.6 974.7 1076.5 26306.9 26577.1 26622.6 26638.9 26764.7 978.2 996.3 1038.5 1060.1 1088.9 13630.1 13856.2 13906.0 14101.1 14222.1 263576.0 266729.7 267216.0 268465.0 268627.0 45796.5 46312.5 46371.0 46510.8 46668.8 1220.3 1224.9 1227.8 1241.4 1246.5 25458.6 26324.6 26529.0 26745.2 26921.6 42716.1 43263.4 43391.1 43405.9 43473.6 238978.0 242838.0 243486.0 244214.0 244627.0 38707.2 43347.1 43354.3 43738.6 44369.8 38824.2 38909.6 39153.2 39726.8 39924.4 32672.0 33108.5 33341.3 33392.3 33556.7 32667.0 33051.7 33108.3 33131.8 33143.7 32596.2 33590.7 33625.3 33634.3 33673.0 28763.5 30694.0 30822.1 30840.9 30913.7 23467.6 23535.6 23771.9 23906.5 23954.0 11:16:04 INFO - 2015-12-16 11:16:04,090 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-12-16 11:16:04,090 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:20950.00 Median:4480.29 stddev:52946.32 (1181.8%) stddev-sans-first:53072.23 11:16:04 INFO - 2015-12-16 11:16:04,090 DEBUG : BROWSER_OUTPUT: Values: 338.4 340.4 340.5 340.8 342.5 14521.5 14688.9 15764.6 16290.1 16916.9 9701.7 9730.4 9875.9 9944.7 9992.8 4348.2 4476.2 4478.1 4482.5 4506.6 4431.5 4454.6 4765.4 4983.3 4984.5 4811.5 4945.3 4946.4 4954.6 4969.0 5693.9 5737.9 5738.3 5753.1 5754.0 4992.6 5090.2 5096.2 5097.2 5116.3 10795.8 10916.2 10929.6 10965.9 11009.2 1722.1 1762.5 1778.5 1854.2 1948.2 8503.7 8557.2 9421.6 9726.0 12146.6 1742.3 1747.6 1750.4 1769.5 1775.5 48615.3 53046.7 55332.0 56917.1 58309.0 8953.3 9342.2 9633.3 9663.0 9670.3 11919.8 12060.8 12069.4 12153.9 12317.3 6971.9 7149.1 7190.6 7245.3 7283.8 7051.9 7068.2 7080.1 7114.2 7124.8 4155.7 4250.0 4253.9 4258.4 4263.2 1610.1 1646.6 1656.7 1662.4 1674.7 862.3 883.2 911.8 914.4 926.8 15151.4 15670.6 15811.2 15818.7 15958.6 758.4 836.7 855.2 861.0 877.9 8060.2 8262.5 8427.9 8562.5 8583.4 319065.0 319979.0 320022.0 323043.0 324492.0 65636.0 67471.0 68975.3 72086.0 77899.2 440.0 452.4 452.4 452.5 454.9 9308.6 9368.2 9449.6 9661.3 9724.5 28792.0 31313.5 31474.0 33045.2 33742.5 35081.8 35664.6 36504.6 38130.0 39285.0 8531.6 8607.7 8727.5 8737.2 8740.0 10883.6 15618.1 15841.6 15985.3 16133.7 13257.5 13513.5 13750.0 13933.9 14069.2 13407.8 13626.7 13930.6 13989.3 14151.2 14022.6 14147.4 14281.4 14495.3 14778.3 8951.1 9009.1 9160.2 9292.2 9306.2 9458.1 11911.5 13170.9 13659.7 14184.1 11:16:04 INFO - 2015-12-16 11:16:04,091 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-12-16 11:16:04,091 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5021.45 Median:6338.45 stddev:2623.36 (41.4%) stddev-sans-first:2617.26 11:16:04 INFO - 2015-12-16 11:16:04,092 DEBUG : BROWSER_OUTPUT: Values: 1485.8 1637.4 1637.9 1671.7 1770.0 7114.5 7145.5 7169.5 7385.7 7423.2 7399.4 7431.5 7465.6 7480.6 7480.9 2118.9 2140.0 2146.0 2154.4 2160.5 2078.5 2098.0 2099.3 2134.4 2172.2 2070.5 2080.8 2081.1 2116.2 2116.2 2103.7 2111.3 2128.3 2132.5 2132.9 2049.3 2108.0 2113.9 2120.0 2120.3 7264.3 7343.4 7347.0 7350.3 7364.2 4214.5 4260.9 4279.6 4279.8 4280.6 2854.2 2858.9 2925.3 2932.0 2934.0 835.2 838.0 864.9 867.4 916.0 9677.7 9806.1 9811.9 9819.5 9821.0 3803.1 3803.4 3865.9 3871.4 3880.2 8037.2 8078.4 8086.2 8088.1 8114.8 4271.6 4272.6 4273.9 4274.9 4279.6 3207.4 3297.2 3790.5 3882.8 3921.8 3223.6 3232.5 3251.0 3266.4 3273.6 961.1 982.3 982.5 986.5 987.4 1158.9 1181.5 1195.3 1209.1 1211.5 6709.3 6723.5 6792.3 6864.1 6874.7 428.6 429.7 430.9 437.4 438.5 5431.5 5470.9 5471.3 5506.9 5509.7 8039.5 8312.5 8355.6 8405.0 8681.0 8309.5 8364.2 8393.1 8396.6 8473.6 6830.4 6848.2 6950.0 6955.4 6979.4 6829.5 6863.9 6884.7 6886.6 6887.3 7682.1 7722.6 7861.3 7872.6 7885.4 7927.8 8022.6 8069.8 8114.6 8148.6 5445.9 5559.9 6470.6 6557.0 6604.1 6775.5 6796.8 6830.7 6839.5 6867.4 6007.2 6326.3 6340.2 6498.2 6616.4 6303.9 6336.7 6392.4 6430.3 6563.9 6549.5 6583.9 6593.2 6608.0 6618.7 6002.8 6119.2 6125.6 6180.4 6193.5 5923.6 5933.1 5946.1 5948.9 5960.9 11:16:04 INFO - 2015-12-16 11:16:04,092 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-12-16 11:16:04,092 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4879.44 Median:5612.60 stddev:1464.89 (26.1%) stddev-sans-first:1428.01 11:16:04 INFO - 2015-12-16 11:16:04,092 DEBUG : BROWSER_OUTPUT: Values: 294.6 308.5 308.9 309.8 312.2 5581.0 5589.3 5623.2 5782.4 5802.5 5569.2 5602.0 5628.6 5635.9 5644.4 4143.3 4259.6 4289.8 4301.8 4304.6 4221.1 4252.1 4255.3 4256.8 4280.7 4237.9 4249.4 4249.4 4250.9 4253.5 4243.0 4248.9 4261.4 4272.4 4273.2 3568.5 3702.5 3703.7 3704.5 3708.9 5240.6 5388.6 5397.7 5399.8 5429.6 4887.4 4902.7 4906.3 4908.5 4912.8 5844.8 5855.4 5861.9 5903.1 5905.0 3905.5 4026.2 4027.1 4033.8 4074.3 6159.2 6221.1 6238.4 6239.0 6242.1 4111.9 4116.6 4133.1 4134.0 4137.6 4200.0 4203.2 4207.7 4212.0 4212.8 4735.3 4844.0 4856.5 4865.2 4906.5 5849.4 5853.9 5858.4 5858.5 5882.6 1442.4 1468.8 1469.8 1473.0 1474.5 978.6 990.3 998.6 1007.5 1011.7 5126.8 5137.2 5140.2 5150.5 5164.3 6109.3 6109.5 6112.1 6122.8 6136.8 5120.6 5131.8 5131.8 5139.2 5149.8 3255.1 3293.6 3310.7 3328.1 3331.6 5714.5 5749.9 5779.2 5788.0 5846.1 6340.8 6364.3 6370.1 6380.1 6382.3 5788.9 5837.4 5839.1 5841.8 5852.6 6008.2 6120.7 6121.4 6147.2 6163.3 6057.5 6057.6 6065.2 6065.7 6069.5 5843.3 5846.1 5854.5 5857.7 5858.5 4144.2 4180.3 4180.7 4183.0 4187.7 6033.9 6175.4 6181.1 6190.4 6190.6 5889.1 5917.1 5918.6 5925.3 5929.3 5925.2 5938.9 5941.3 5947.8 5970.8 5631.0 5760.2 5783.6 5812.0 5818.2 5980.2 5986.3 5991.0 5992.7 5995.2 5820.8 5826.8 5844.9 5845.3 5857.6 11:16:04 INFO - 2015-12-16 11:16:04,092 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-12-16 11:16:04,092 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12031.02 Median:43278.18 stddev:13323.04 (30.8%) stddev-sans-first:13333.05 11:16:04 INFO - 2015-12-16 11:16:04,093 DEBUG : BROWSER_OUTPUT: Values: 661.6 720.8 767.7 773.5 781.1 11662.4 11791.8 11800.2 11841.3 11866.2 11455.5 11795.1 11804.5 11832.1 11837.5 804.3 820.8 822.8 823.4 841.7 818.3 819.4 820.6 821.2 827.4 861.3 862.1 864.6 869.9 871.0 855.2 860.0 862.8 863.5 864.8 630.1 641.1 641.6 641.9 642.1 12258.3 12317.6 12329.8 12397.6 12413.1 10970.3 11166.1 11168.1 11241.5 11413.1 9459.0 9476.6 9482.4 9591.1 9613.0 3126.4 3185.2 3219.1 3240.9 3242.1 40166.4 40635.6 40638.6 40667.8 40774.2 9060.0 9164.4 9175.0 9218.5 9459.2 15268.0 15330.5 15368.5 15858.0 15969.4 5862.7 5971.4 5980.3 6009.5 6202.1 3480.0 3518.7 3527.2 3530.6 3596.9 2548.4 2550.9 2554.5 2556.3 2563.3 476.4 477.0 478.4 492.4 494.7 468.9 487.3 576.4 576.7 597.1 7515.7 7559.0 7625.8 7698.7 7750.7 499.1 536.5 610.7 625.6 629.0 3669.3 3942.9 3975.1 4001.5 4080.5 45999.0 46148.3 46844.3 47140.8 47177.3 41919.8 43064.6 43114.4 43167.4 43389.0 39141.6 39445.0 39580.0 40616.4 40774.2 7650.1 7872.7 7971.9 8053.5 8117.8 29277.4 30058.7 30147.8 30174.8 32153.2 37408.0 37562.4 38073.6 38582.8 39222.6 9575.5 9850.7 10188.9 10194.2 10542.9 11041.0 11048.4 11170.6 11494.4 12025.2 10608.3 10730.5 10996.8 11138.2 11457.8 10482.0 10567.7 10568.6 11067.8 11209.5 9776.5 10433.6 10489.7 10514.9 11001.3 9026.5 9037.6 9134.5 9296.3 9398.8 8901.0 9012.3 9154.2 9317.4 9474.0 11:16:04 INFO - 2015-12-16 11:16:04,094 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:16:04 INFO - 2015-12-16 11:16:04,094 DEBUG : BROWSER_OUTPUT: 11:16:04 INFO - 2015-12-16 11:16:04,828 INFO : Browser exited with error code: 0 11:16:04 INFO - 2015-12-16 11:16:04,847 INFO : Completed test dromaeo_css (00:18:34) 11:16:04 INFO - 2015-12-16 11:16:04,847 INFO : Starting test kraken 11:16:04 INFO - 2015-12-16 11:16:04,847 DEBUG : operating with platform_type : linux_ 11:16:04 INFO - 2015-12-16 11:16:04,847 INFO : Initialising browser for kraken test... 11:16:04 INFO - 2015-12-16 11:16:04,853 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnry8Gs/profile http://localhost:42086/getInfo.html 11:16:09 INFO - 2015-12-16 11:16:09,224 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:16:09 INFO - 2015-12-16 11:16:09,224 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:16:09 INFO - 2015-12-16 11:16:09,224 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:16:09 INFO - 2015-12-16 11:16:09,224 DEBUG : BROWSER_OUTPUT: __metrics 11:16:09 INFO - 2015-12-16 11:16:09,341 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] 11:16:10 INFO - 2015-12-16 11:16:10,288 INFO : Browser initialized. 11:16:10 INFO - 2015-12-16 11:16:10,289 INFO : Running cycle 1/1 for kraken test... 11:16:10 INFO - 2015-12-16 11:16:10,289 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnry8Gs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:16:22 INFO - 2015-12-16 11:16:22,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 143536128 11:16:22 INFO - 2015-12-16 11:16:22,304 DEBUG : BROWSER_OUTPUT: 11:16:24 INFO - 2015-12-16 11:16:24,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42086/tests/kraken/driver.html?testName=audio-beat-detection) 11:16:25 INFO - 2015-12-16 11:16:25,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 144199680 11:16:25 INFO - 2015-12-16 11:16:25,513 DEBUG : BROWSER_OUTPUT: 11:16:28 INFO - 2015-12-16 11:16:28,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42086/tests/kraken/driver.html?testName=audio-dft) 11:16:28 INFO - 2015-12-16 11:16:28,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 143048704 11:16:28 INFO - 2015-12-16 11:16:28,858 DEBUG : BROWSER_OUTPUT: 11:16:31 INFO - 2015-12-16 11:16:31,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42086/tests/kraken/driver.html?testName=audio-fft) 11:16:32 INFO - 2015-12-16 11:16:32,349 DEBUG : BROWSER_OUTPUT: RSS: Main: 138342400 11:16:32 INFO - 2015-12-16 11:16:32,349 DEBUG : BROWSER_OUTPUT: 11:16:34 INFO - 2015-12-16 11:16:34,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42086/tests/kraken/driver.html?testName=audio-oscillator) 11:16:35 INFO - 2015-12-16 11:16:35,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 138993664 11:16:35 INFO - 2015-12-16 11:16:35,032 DEBUG : BROWSER_OUTPUT: 11:16:37 INFO - 2015-12-16 11:16:37,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42086/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:16:37 INFO - 2015-12-16 11:16:37,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 139055104 11:16:37 INFO - 2015-12-16 11:16:37,887 DEBUG : BROWSER_OUTPUT: 11:16:40 INFO - 2015-12-16 11:16:40,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42086/tests/kraken/driver.html?testName=imaging-darkroom) 11:16:41 INFO - 2015-12-16 11:16:41,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 140488704 11:16:41 INFO - 2015-12-16 11:16:41,539 DEBUG : BROWSER_OUTPUT: 11:16:45 INFO - 2015-12-16 11:16:45,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42086/tests/kraken/driver.html?testName=imaging-desaturate) 11:16:45 INFO - 2015-12-16 11:16:45,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 139145216 11:16:45 INFO - 2015-12-16 11:16:45,613 DEBUG : BROWSER_OUTPUT: 11:16:48 INFO - 2015-12-16 11:16:48,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42086/tests/kraken/driver.html?testName=json-parse-financial) 11:16:49 INFO - 2015-12-16 11:16:49,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 139702272 11:16:49 INFO - 2015-12-16 11:16:49,176 DEBUG : BROWSER_OUTPUT: 11:16:50 INFO - 2015-12-16 11:16:50,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42086/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:16:51 INFO - 2015-12-16 11:16:51,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 140140544 11:16:51 INFO - 2015-12-16 11:16:51,556 DEBUG : BROWSER_OUTPUT: 11:16:53 INFO - 2015-12-16 11:16:53,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42086/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:16:54 INFO - 2015-12-16 11:16:54,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 140017664 11:16:54 INFO - 2015-12-16 11:16:54,064 DEBUG : BROWSER_OUTPUT: 11:16:56 INFO - 2015-12-16 11:16:56,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42086/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:16:56 INFO - 2015-12-16 11:16:56,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 140218368 11:16:56 INFO - 2015-12-16 11:16:56,826 DEBUG : BROWSER_OUTPUT: 11:16:59 INFO - 2015-12-16 11:16:59,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42086/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:17:00 INFO - 2015-12-16 11:17:00,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 140754944 11:17:00 INFO - 2015-12-16 11:17:00,033 DEBUG : BROWSER_OUTPUT: 11:17:02 INFO - 2015-12-16 11:17:02,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42086/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:17:03 INFO - 2015-12-16 11:17:03,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 140218368 11:17:03 INFO - 2015-12-16 11:17:03,295 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42086/tests/kraken/driver.html?testName=ai-astar) 11:17:05 INFO - 2015-12-16 11:17:05,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 141283328 11:17:05 INFO - 2015-12-16 11:17:05,319 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,323 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:17:05 INFO - 2015-12-16 11:17:05,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:17:05 INFO - 2015-12-16 11:17:05,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:17:05 INFO - 2015-12-16 11:17:05,323 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:17:05 INFO - 2015-12-16 11:17:05,323 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;111;114;114;115;127;114;114;114;117 11:17:05 INFO - 2015-12-16 11:17:05,324 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;131;156;170;138;160;154;135;174;131 11:17:05 INFO - 2015-12-16 11:17:05,324 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;165;162;171;166;167;162;163;163 11:17:05 INFO - 2015-12-16 11:17:05,324 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;74;76;128;74;79;79;73;92 11:17:05 INFO - 2015-12-16 11:17:05,324 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;100;138;98;96;95;134;95;95;126 11:17:05 INFO - 2015-12-16 11:17:05,324 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;110;121;110;110;110;109;110 11:17:05 INFO - 2015-12-16 11:17:05,325 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;148;148;148;148;147;148;147 11:17:05 INFO - 2015-12-16 11:17:05,325 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;97;97;96;95;96;96;97;96 11:17:05 INFO - 2015-12-16 11:17:05,325 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;74;76;74;77;75;77;81;75;73 11:17:05 INFO - 2015-12-16 11:17:05,325 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;78;68;69;67;69;69;68;68;68;67 11:17:05 INFO - 2015-12-16 11:17:05,325 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;87;86;96;87;85;85;88;94;86 11:17:05 INFO - 2015-12-16 11:17:05,325 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;134;124;134;130;122;136;125;137;123 11:17:05 INFO - 2015-12-16 11:17:05,325 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;150;156;160;153;144;154;152;145;144 11:17:05 INFO - 2015-12-16 11:17:05,325 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;72;73;73;72;70;71;72;70 11:17:05 INFO - 2015-12-16 11:17:05,326 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:17:05 INFO - 2015-12-16 11:17:05,326 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:17:05 INFO - 2015-12-16 11:17:05,326 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,792 11:17:05 INFO - 2015-12-16 11:17:05,326 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:17:05 INFO - 2015-12-16 11:17:05,326 DEBUG : BROWSER_OUTPUT: __startTimestamp1450293425321__endTimestamp 11:17:05 INFO - 2015-12-16 11:17:05,326 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,334 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:17:05 INFO - 2015-12-16 11:17:05,334 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:17:05 INFO - 2015-12-16 11:17:05,334 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,334 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.60 Median:114.50 stddev:4.30 (3.8%) stddev-sans-first:4.56 11:17:05 INFO - 2015-12-16 11:17:05,334 DEBUG : BROWSER_OUTPUT: Values: 116.0 111.0 114.0 114.0 115.0 127.0 114.0 114.0 114.0 117.0 11:17:05 INFO - 2015-12-16 11:17:05,334 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,334 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.60 Median:156.50 stddev:15.86 (10.1%) stddev-sans-first:16.65 11:17:05 INFO - 2015-12-16 11:17:05,334 DEBUG : BROWSER_OUTPUT: Values: 157.0 131.0 156.0 170.0 138.0 160.0 154.0 135.0 174.0 131.0 11:17:05 INFO - 2015-12-16 11:17:05,334 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,334 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.80 (1.7%) stddev-sans-first:2.91 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 165.0 162.0 171.0 166.0 167.0 162.0 163.0 163.0 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:17.32 (23.1%) stddev-sans-first:17.92 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 74.0 76.0 128.0 74.0 79.0 79.0 73.0 92.0 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.10 Median:95.00 stddev:17.96 (18.9%) stddev-sans-first:18.41 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: Values: 94.0 100.0 138.0 98.0 96.0 95.0 134.0 95.0 95.0 126.0 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:111.10 Median:110.00 stddev:3.51 (3.2%) stddev-sans-first:3.70 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 110.0 121.0 110.0 110.0 110.0 109.0 110.0 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 148.0 148.0 148.0 148.0 147.0 148.0 147.0 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:17:05 INFO - 2015-12-16 11:17:05,335 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 97.0 97.0 96.0 95.0 96.0 96.0 97.0 96.0 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.70 Median:75.50 stddev:2.26 (3.0%) stddev-sans-first:2.39 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 76.0 74.0 77.0 75.0 77.0 81.0 75.0 73.0 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:68.50 stddev:3.21 (4.7%) stddev-sans-first:0.78 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: Values: 78.0 68.0 69.0 67.0 69.0 69.0 68.0 68.0 68.0 67.0 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:87.00 stddev:3.83 (4.4%) stddev-sans-first:3.99 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 86.0 96.0 87.0 85.0 85.0 88.0 94.0 86.0 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:133.00 stddev:5.72 (4.3%) stddev-sans-first:6.00 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: Values: 132.0 134.0 124.0 134.0 130.0 122.0 136.0 125.0 137.0 123.0 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:152.50 stddev:5.88 (3.9%) stddev-sans-first:5.64 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: Values: 143.0 150.0 156.0 160.0 153.0 144.0 154.0 152.0 145.0 144.0 11:17:05 INFO - 2015-12-16 11:17:05,336 DEBUG : BROWSER_OUTPUT: 11:17:05 INFO - 2015-12-16 11:17:05,337 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:1.18 (1.6%) stddev-sans-first:1.12 11:17:05 INFO - 2015-12-16 11:17:05,337 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 72.0 73.0 73.0 72.0 70.0 71.0 72.0 70.0 11:17:05 INFO - 2015-12-16 11:17:05,337 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:17:05 INFO - 2015-12-16 11:17:05,337 DEBUG : BROWSER_OUTPUT: 11:17:06 INFO - 2015-12-16 11:17:06,188 INFO : Browser exited with error code: 0 11:17:06 INFO - 2015-12-16 11:17:06,244 INFO : Completed test kraken (00:01:01) 11:17:06 INFO - 2015-12-16 11:17:06,244 INFO : Starting test v8_7 11:17:06 INFO - 2015-12-16 11:17:06,244 DEBUG : operating with platform_type : linux_ 11:17:06 INFO - 2015-12-16 11:17:06,244 INFO : Initialising browser for v8_7 test... 11:17:06 INFO - 2015-12-16 11:17:06,250 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK1DjCC/profile http://localhost:42086/getInfo.html 11:17:10 INFO - 2015-12-16 11:17:10,407 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:17:10 INFO - 2015-12-16 11:17:10,407 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:17:10 INFO - 2015-12-16 11:17:10,407 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:17:10 INFO - 2015-12-16 11:17:10,407 DEBUG : BROWSER_OUTPUT: __metrics 11:17:10 INFO - 2015-12-16 11:17:10,576 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] 11:17:11 INFO - 2015-12-16 11:17:11,496 INFO : Browser initialized. 11:17:11 INFO - 2015-12-16 11:17:11,497 INFO : Running cycle 1/1 for v8_7 test... 11:17:11 INFO - 2015-12-16 11:17:11,497 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK1DjCC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:17:23 INFO - 2015-12-16 11:17:23,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 142962688 11:17:23 INFO - 2015-12-16 11:17:23,536 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42086/tests/v8_7/run.html (next: http://localhost:42086/tests/v8_7/run.html) 11:17:45 INFO - 2015-12-16 11:17:45,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 138223616 11:17:45 INFO - 2015-12-16 11:17:45,284 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,284 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:17:45 INFO - 2015-12-16 11:17:45,284 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:17:45 INFO - 2015-12-16 11:17:45,284 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:17:45 INFO - 2015-12-16 11:17:45,284 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:17:45 INFO - 2015-12-16 11:17:45,284 DEBUG : BROWSER_OUTPUT: |0;Richards;167.7570877369569 11:17:45 INFO - 2015-12-16 11:17:45,285 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.6172607879925 11:17:45 INFO - 2015-12-16 11:17:45,285 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.97780275358247 11:17:45 INFO - 2015-12-16 11:17:45,285 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5284.210526315789 11:17:45 INFO - 2015-12-16 11:17:45,285 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1066.0980810234541 11:17:45 INFO - 2015-12-16 11:17:45,285 DEBUG : BROWSER_OUTPUT: |5;Earley;742.9420505200594 11:17:45 INFO - 2015-12-16 11:17:45,285 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 11:17:45 INFO - 2015-12-16 11:17:45,286 DEBUG : BROWSER_OUTPUT: |7;RegExp;27054.054054054053 11:17:45 INFO - 2015-12-16 11:17:45,286 DEBUG : BROWSER_OUTPUT: |8;Splay;594.1770647653001 11:17:45 INFO - 2015-12-16 11:17:45,286 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 11:17:45 INFO - 2015-12-16 11:17:45,286 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:17:45 INFO - 2015-12-16 11:17:45,287 DEBUG : BROWSER_OUTPUT: __startTimestamp1450293465282__endTimestamp 11:17:45 INFO - 2015-12-16 11:17:45,287 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,287 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:17:45 INFO - 2015-12-16 11:17:45,287 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:17:45 INFO - 2015-12-16 11:17:45,287 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,287 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.76 Median:167.76 stddev:0.00 (0.0%) 11:17:45 INFO - 2015-12-16 11:17:45,287 DEBUG : BROWSER_OUTPUT: Values: 167.8 11:17:45 INFO - 2015-12-16 11:17:45,288 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,288 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.62 Median:187.62 stddev:0.00 (0.0%) 11:17:45 INFO - 2015-12-16 11:17:45,288 DEBUG : BROWSER_OUTPUT: Values: 187.6 11:17:45 INFO - 2015-12-16 11:17:45,288 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,288 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 11:17:45 INFO - 2015-12-16 11:17:45,288 DEBUG : BROWSER_OUTPUT: Values: 281.0 11:17:45 INFO - 2015-12-16 11:17:45,289 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,289 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5284.21 Median:5284.21 stddev:0.00 (0.0%) 11:17:45 INFO - 2015-12-16 11:17:45,289 DEBUG : BROWSER_OUTPUT: Values: 5284.2 11:17:45 INFO - 2015-12-16 11:17:45,289 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,290 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 11:17:45 INFO - 2015-12-16 11:17:45,291 DEBUG : BROWSER_OUTPUT: Values: 1066.1 11:17:45 INFO - 2015-12-16 11:17:45,291 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,291 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:742.94 Median:742.94 stddev:0.00 (0.0%) 11:17:45 INFO - 2015-12-16 11:17:45,291 DEBUG : BROWSER_OUTPUT: Values: 742.9 11:17:45 INFO - 2015-12-16 11:17:45,291 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,291 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 11:17:45 INFO - 2015-12-16 11:17:45,291 DEBUG : BROWSER_OUTPUT: Values: 12256.1 11:17:45 INFO - 2015-12-16 11:17:45,291 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,292 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27054.05 Median:27054.05 stddev:0.00 (0.0%) 11:17:45 INFO - 2015-12-16 11:17:45,292 DEBUG : BROWSER_OUTPUT: Values: 27054.1 11:17:45 INFO - 2015-12-16 11:17:45,292 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,292 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:594.18 Median:594.18 stddev:0.00 (0.0%) 11:17:45 INFO - 2015-12-16 11:17:45,292 DEBUG : BROWSER_OUTPUT: Values: 594.2 11:17:45 INFO - 2015-12-16 11:17:45,292 DEBUG : BROWSER_OUTPUT: 11:17:45 INFO - 2015-12-16 11:17:45,292 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 11:17:45 INFO - 2015-12-16 11:17:45,292 DEBUG : BROWSER_OUTPUT: Values: 4854.4 11:17:45 INFO - 2015-12-16 11:17:45,292 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:17:45 INFO - 2015-12-16 11:17:45,292 DEBUG : BROWSER_OUTPUT: 11:17:46 INFO - 2015-12-16 11:17:46,168 INFO : Browser exited with error code: 0 11:17:46 INFO - 2015-12-16 11:17:46,183 INFO : Completed test v8_7 (00:00:39) 11:17:46 INFO - 2015-12-16 11:17:46,279 INFO : Completed test suite (00:20:15) 11:17:46 INFO - 2015-12-16 11:17:46,279 DEBUG : Working with test: dromaeo_css 11:17:46 INFO - 2015-12-16 11:17:46,279 DEBUG : Generating results file: dromaeo_css 11:17:46 INFO - 2015-12-16 11:17:46,281 DEBUG : Working with test: kraken 11:17:46 INFO - 2015-12-16 11:17:46,281 DEBUG : Generating results file: kraken 11:17:46 INFO - 2015-12-16 11:17:46,281 INFO : javascript benchmark 11:17:46 INFO - 2015-12-16 11:17:46,281 DEBUG : Working with test: v8_7 11:17:46 INFO - 2015-12-16 11:17:46,281 DEBUG : Generating results file: v8_7 11:17:46 INFO - 2015-12-16 11:17:46,282 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:17:46 INFO - 2015-12-16 11:17:46,332 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 11:17:46 INFO - 2015-12-16 11:17:46,332 DEBUG : process_Request line: dromaeo_css 6296.77 graph.html#tests=[[72,132,43]] 11:17:46 INFO - 2015-12-16 11:17:46,333 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:17:46 INFO - 2015-12-16 11:17:46,361 DEBUG : process_Request line: kraken 1558.80 graph.html#tests=[[232,132,43]] 11:17:46 INFO - 2015-12-16 11:17:46,362 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:17:46 INFO - 2015-12-16 11:17:46,390 DEBUG : process_Request line: v8_7 21117.32 graph.html#tests=[[230,132,43]] 11:17:46 INFO - 2015-12-16 11:17:46,391 INFO : javascript benchmark 11:17:46 INFO - 2015-12-16 11:17:46,395 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2682.9463410731787, 2711.7288271172897, 2744.492268930248, 2761.406297646007, 2770.0443347045275, 4676.1349150407195, 4773.761311934402, 4807.759612019402, 4810.06203790261, 4876.658633895629, 4707.78814953327, 4723.976380118103, 4728.834490792823, 4744.1934871072, 4750.0, 4413.514513403523, 4448.688591798567, 4494.0, 4505.144022635705, 4514.322851572274, 4416.470023597173, 4453.955460445386, 4454.955450445486, 4462.486814016397, 4494.752788596642, 4241.172971270604, 4359.280718681413, 4452.243118669801, 4471.0, 4501.324801279818, 4432.689711720181, 4448.3549885266775, 4454.265046267362, 4458.286674132156, 4486.371907932892, 4256.4679415073115, 4427.557244275579, 4436.534163912807, 4473.5526447355005, 4475.4181956345465, 4590.311453282001, 4603.953960460386, 4712.057588482283, 4731.148393289207, 4772.260299653559, 5077.238414237857, 5127.743612819344, 5129.563987061104, 5133.563647090002, 5178.508041736029, 4904.386951631046, 5151.124308867502, 5159.793608255665, 5163.845084647466, 5173.068847607429, 4665.2768820832825, 4722.055588882237, 4776.2119250324, 4801.5438533339275, 4846.927296090562, 5230.581553475713, 5235.267062611238, 5237.5286224239235, 5273.709945953009, 5278.181881808326, 4806.134895718735, 4880.267959806058, 5031.245313203049, 5036.471170527042, 5037.471065538066, 5093.719845408538, 5115.283860259567, 5131.666441681354, 5149.948500515022, 5189.844304670866, 5094.719790411563, 5106.540411362995, 5112.539871411516, 5118.38579370478, 5139.948600513947, 4818.373611430492, 4931.630127740362, 4959.80964568501, 5052.0, 5075.0, 4243.936340954888, 4255.97872010638, 4283.721558098714, 4299.097189590221, 4333.328334108218, 3733.253349330145, 3745.3632882410056, 3762.9623703762613, 3763.7553559018575, 3802.5817160112365, 4292.892677683083, 4361.345798130305, 4375.606195442426, 4453.3320001999955, 4460.375547423363, 5127.97436012825, 5139.177731562932, 5140.742962851918, 5160.174372100446, 5177.870553236124, 4412.911741765147, 4427.26950053244, 4431.468223813163, 4442.8222871085445, 4498.212812757754, 4408.228560001987, 4454.977725111418, 4505.0, 4524.705894116872, 4549.044700612908, 4876.292937524039, 4909.5090490950615, 4911.926321105115, 4913.656044076952, 4944.01119776039, 4919.581835543876, 5134.460881607378, 5180.222966555047, 5190.325217842171, 5223.791048358175, 4806.807727690853, 4824.445188803192, 4900.656954013185, 4907.2393778964315, 4933.876653083558, 5074.594032477319, 5100.285959965682, 5112.463191364853, 5118.181091025418, 5148.613853961043, 4942.233953737176, 5060.342155519759, 5170.663906846043, 5186.8962620746615, 5186.948130518646, 4895.926561101515, 4941.184704523714, 4946.258061290835, 4966.354373931365, 5027.0, 4939.357883475269, 4978.2034874419915, 5017.272495488207, 5018.924716129188, 5050.898982020265, 4710.552497512731, 4856.053069651384, 4902.362692849907, 4915.410150781929, 4954.727489988085, 4983.0, 5033.697978121324, 5038.2190760432195, 5038.773255203598, 5068.569171620306, 4913.410390753133, 4953.331300274417, 4958.256261560795, 4961.454240033521, 5018.4730603286125], "unit": "score", "name": "dojo.html", "value": 4698.043919642726}, {"lowerIsBetter": false, "replicates": [528.9841304760859, 555.6249531566192, 570.9571782116342, 576.9653820770754, 590.7666471743659, 26419.339516512096, 36010.63989360109, 36173.45739813905, 36225.275494490095, 36388.45417318743, 38866.41700374489, 39387.80306098473, 39448.0, 39467.605323946824, 39602.207955840866, 7639.204786875094, 7776.339011184056, 7787.493812902171, 7801.609919504031, 7830.29527342539, 7790.688372465094, 7795.298423141916, 7894.802629934269, 7900.64447099879, 7913.406494512935, 7722.459427840054, 7760.689572417096, 7819.569923654197, 7823.374130069609, 7845.058592968823, 7847.843043139133, 7856.72501462449, 7912.525248485109, 7917.762467126025, 7921.36629069673, 7758.922410775876, 7888.368930485547, 7889.092754333267, 7891.9605401973195, 7909.564973926432, 37161.62838371609, 37311.440328395096, 37672.0, 37712.43431348504, 37776.244475110616, 2875.180573536553, 2884.6538415390287, 2938.5885975963383, 2956.482615542293, 3523.94714079289, 28047.71952280492, 28212.435751285066, 28236.85881570579, 28272.15183544497, 28321.716782832114, 3237.676232376767, 3302.9009129725905, 3324.4514655081884, 3378.3074469733647, 3398.5411969384063, 212712.0, 213952.0, 213953.0, 214470.0, 214830.0, 53236.46763532393, 53662.0, 57275.71362143246, 63492.0, 65101.34898651048, 55612.72193639006, 55711.0, 55753.44246557564, 55783.0, 55993.16010259849, 13403.396847141901, 13413.530526431528, 13428.0, 13430.328483575977, 13449.663758406117, 10394.584216631401, 10415.94792026035, 10440.63457778974, 10487.895121048692, 10507.842382364272, 19482.707759383622, 19611.313604024075, 19778.0, 19829.504262393555, 19833.0, 7686.500377475446, 7844.37245020397, 7921.762347129596, 7930.0880398753725, 7938.206179382016, 909.1181553892714, 954.3367359684952, 965.6282331302499, 974.7319487140951, 1076.5263284154946, 26306.86846565755, 26577.069802556816, 26622.6006609901, 26638.866805665846, 26764.732352676612, 978.2467500024941, 996.2602842183994, 1038.4548112241134, 1060.1201003167353, 1088.9328458110938, 13630.1140425872, 13856.237906915016, 13906.0, 14101.083429577046, 14222.146671199762, 263576.0, 266729.666351667, 267216.0, 268465.0, 268627.0, 45796.54203457989, 46312.5368746315, 46371.0, 46510.76744616323, 46668.7666561665, 1220.3166226912956, 1224.9020078393708, 1227.8281040654315, 1241.4351470081272, 1246.4640204712061, 25458.618120727835, 26324.605130922668, 26529.0, 26745.197644070708, 26921.596176057767, 42716.145677086904, 43263.35104973365, 43391.13217735691, 43405.914852128946, 43473.56526434695, 238978.0, 242838.0, 243486.0, 244214.0, 244627.0, 38707.225855483295, 43347.133057339306, 43354.349684754125, 43738.56261437345, 44369.778151109036, 38824.223515530095, 38909.61090389173, 39153.21693566056, 39726.801365992986, 39924.40113398359, 32672.0, 33108.503372449915, 33341.33317333688, 33392.33215335728, 33556.664433355356, 32667.0, 33051.66948330582, 33108.337833243684, 33131.83434082814, 33143.66856331406, 32596.185095372806, 33590.664093358755, 33625.32749345048, 33634.327313453105, 33673.0, 28763.45025589814, 30694.0, 30822.075337739905, 30840.94425313153, 30913.72333516493, 23467.647985280575, 23535.646965295877, 23771.881140594185, 23906.52186956286, 23954.0], "unit": "score", "name": "ext.html", "value": 17124.349236631715}, {"lowerIsBetter": false, "replicates": [338.4060972992398, 340.4314794293531, 340.51306631516934, 340.76146697311856, 342.525602041173, 14521.491747788816, 14688.853111468881, 15764.605884852885, 16290.10404427756, 16916.91541542292, 9701.708948731532, 9730.367526110798, 9875.851862222073, 9944.701658950225, 9992.750181245472, 4348.239058164824, 4476.171908196978, 4478.0596074824325, 4482.529334419888, 4506.639468842484, 4431.534688857671, 4454.621357184643, 4765.356676848615, 4983.327250821148, 4984.501549845005, 4811.518848115195, 4945.282933974571, 4946.356973593428, 4954.628402869781, 4968.950310496885, 5693.914591281134, 5737.88524229513, 5738.254026976508, 5753.050746626823, 5753.971230143843, 4992.6005919526715, 5090.160123579605, 5096.210087436416, 5097.23541468779, 5116.309298244727, 10795.784084318348, 10916.181286403473, 10929.617463388822, 10965.890341096567, 11009.174311926557, 1722.1303241862904, 1762.488878225313, 1778.457570441015, 1854.249029143199, 1948.2401863273335, 8503.702370417006, 8557.22984931353, 9421.62313507459, 9725.951370243174, 12146.5748698796, 1742.3466200174935, 1747.571844898008, 1750.422360620992, 1769.4780039888265, 1775.5472354549636, 48615.27077093846, 53046.734766326306, 55332.0, 56917.14624280639, 58309.0, 8953.328500362499, 9342.159205671522, 9633.277504187214, 9663.0, 9670.323077384515, 11919.821202681967, 12060.758784824255, 12069.396530173632, 12153.93923030397, 12317.260964342167, 6971.930280697229, 7149.106361704787, 7190.64046797658, 7245.275472452818, 7283.817904552428, 7051.858962820715, 7068.187158476738, 7080.114985626797, 7114.217436082027, 7124.821879453055, 4155.729877557949, 4249.957500424956, 4253.893652658709, 4258.446401967724, 4263.211305908417, 1610.1385758619317, 1646.6048148444288, 1656.7100757367411, 1662.4098445052075, 1674.7320428731346, 862.2756884217288, 883.1874675298741, 911.8495448250965, 914.3736540469666, 926.754410081329, 15151.393944242327, 15670.561164779008, 15811.209439527978, 15818.683626327409, 15958.601034973986, 758.4122305213393, 836.6820608168857, 855.2473823035689, 861.0442408926087, 877.8727084572702, 8060.153683863227, 8262.545559994258, 8427.915720842713, 8562.48625082497, 8583.442076265022, 319065.0, 319979.0, 320022.0, 323043.0, 324492.0, 65636.0, 67471.0, 68975.31024689789, 72086.0, 77899.2210077892, 439.973601583906, 452.38927447945014, 452.4321975920199, 452.4886877828033, 454.9317602359606, 9308.627654893728, 9368.203702685349, 9449.622015119317, 9661.323707340418, 9724.465154416575, 28792.0, 31313.530297046018, 31474.0, 33045.17387065342, 33742.49386259257, 35081.82459087688, 35664.64335356717, 36504.63495365012, 38130.0, 39285.0, 8531.573421328785, 8607.741767746978, 8727.476351418934, 8737.169968852948, 8740.0, 10883.619073332395, 15618.062916225063, 15841.603959901095, 15985.280662370455, 16133.677326453171, 13257.53598624082, 13513.459461621425, 13750.0, 13933.930330348283, 14069.226192559097, 13407.798883016567, 13626.659333516345, 13930.58208253754, 13989.300534973007, 14151.221682807545, 14022.579322620337, 14147.36336864823, 14281.357338919981, 14495.347709353315, 14778.261086945824, 8951.060138685605, 9009.099090090938, 9160.221381182673, 9292.210162136023, 9306.208972237435, 9458.101480359355, 11911.463984120563, 13170.934145329595, 13659.658508537366, 14184.148951062969], "unit": "score", "name": "jquery.html", "value": 7608.789860910183}, {"lowerIsBetter": false, "replicates": [1485.814273215848, 1637.4105322084047, 1637.9344826206952, 1671.6990941630506, 1770.0, 7114.501984861049, 7145.5355401898905, 7169.498135130543, 7385.7414990475345, 7423.2205618410035, 7399.445041621886, 7431.5169513981555, 7465.626718664059, 7480.625968701556, 7480.925190748091, 2118.8834614096218, 2139.967900481494, 2145.9892700536475, 2154.353693891834, 2160.503084290614, 2078.490769761411, 2097.979020209794, 2099.2862426774896, 2134.359692092366, 2172.2071443923014, 2070.492729281321, 2080.7503099628066, 2081.0739221046642, 2116.2275769344233, 2116.238154264471, 2103.6949642301856, 2111.2505060703384, 2128.3402145334917, 2132.4775430019745, 2132.8826914519773, 2049.3358633776033, 2108.0, 2113.8837363944976, 2119.98940005299, 2120.289702949514, 7264.273572642746, 7343.3758130558435, 7347.0, 7350.264973502661, 7364.153122390887, 4214.536400995888, 4260.850870219528, 4279.550647182064, 4279.764612946286, 4280.5719428057255, 2854.2293580733085, 2858.9142325730263, 2925.312551550384, 2932.0470846974818, 2934.0464349086633, 835.1815221083311, 837.9664813407456, 864.930805535562, 867.418829384314, 916.0427353415697, 9677.661281855171, 9806.117449429514, 9811.90188098117, 9819.459929703935, 9821.0, 3803.1442925341576, 3803.372443546784, 3865.9226815463535, 3871.380579107329, 3880.1851611161974, 8037.23646253605, 8078.39412044099, 8086.1913808618665, 8088.11030786613, 8114.797130071795, 4271.615554600101, 4272.6154646082, 4273.87178384649, 4274.935875961863, 4279.593438623326, 3207.4386982278006, 3297.225152089257, 3790.469334293201, 3882.825272862728, 3921.784301863368, 3223.564818749439, 3232.466643003925, 3251.0, 3266.4283750343593, 3273.607167139911, 961.0725649748026, 982.2878413150409, 982.4694664880884, 986.5363279258737, 987.4322264697684, 1158.9188756787112, 1181.4919584578543, 1195.2708847602955, 1209.0629761934395, 1211.5335595795507, 6709.29552397001, 6723.529352945345, 6792.252852186256, 6864.141982252218, 6874.65626718662, 428.6270944278498, 429.66271476891114, 430.9353596960481, 437.36145227966887, 438.49353996134516, 5431.53831924283, 5470.9452905471235, 5471.261379713687, 5506.862328441741, 5509.696966666872, 8039.5176289422825, 8312.5428101455, 8355.582220888931, 8404.957975210085, 8680.956595216983, 8309.459885107448, 8364.163583641588, 8393.118722534167, 8396.622152003174, 8473.618687159093, 6830.419414349736, 6848.246692863781, 6950.0, 6955.408790252784, 6979.371856532936, 6829.4877884157895, 6863.931360686329, 6884.690188941409, 6886.621235832077, 6887.311268873073, 7682.116556595839, 7722.6138693063995, 7861.331786798186, 7872.606369681607, 7885.408594355561, 7927.84144317122, 8022.638981245741, 8069.838603227785, 8114.5942702865805, 8148.551829649189, 5445.891082178255, 5559.9444005561045, 6470.644114573555, 6557.049227862029, 6604.075429439787, 6775.525713200029, 6796.796096117125, 6830.726770929107, 6839.487038472234, 6867.381935625817, 6007.219061521974, 6326.3041065483685, 6340.175777149126, 6498.187726534184, 6616.4045235929, 6303.936960630518, 6336.714847831767, 6392.360763923571, 6430.292667806444, 6563.9343606563325, 6549.4760419167305, 6583.934160658332, 6593.175853018372, 6607.9669601651685, 6618.7352505899225, 6002.759889604367, 6119.204503414528, 6125.632462052291, 6180.412860778219, 6193.473554747717, 5923.644581324962, 5933.05071188625, 5946.108083787293, 5948.910766338422, 5960.850978725566], "unit": "score", "name": "mootools.html", "value": 4048.1046837188487}, {"lowerIsBetter": false, "replicates": [294.5669865298012, 308.5033096714291, 308.8517511594433, 309.793986998646, 312.20076603894046, 5581.0, 5589.27339445872, 5623.156526521024, 5782.421757824221, 5802.535797136229, 5569.164625306206, 5602.047651899176, 5628.605997580171, 5635.887282254363, 5644.350899646532, 4143.254214241435, 4259.616634502894, 4289.785510724467, 4301.849435269766, 4304.612584867361, 4221.113566151112, 4252.14957008598, 4255.255330317182, 4256.787160641971, 4280.743155410685, 4237.872863814075, 4249.426327445802, 4249.4475718156755, 4250.893727656818, 4253.532111467736, 4242.97878510607, 4248.874048377167, 4261.403403523509, 4272.423222864904, 4273.166732487166, 3568.536090308269, 3702.500162478085, 3703.7222208334215, 3704.462852886343, 3708.87018954338, 5240.580753539708, 5388.649737767072, 5397.7031263280505, 5399.757010934478, 5429.647072940246, 4887.3890763654545, 4902.730349830758, 4906.288588154734, 4908.460069392364, 4912.778924948386, 5844.766209351621, 5855.355910849803, 5861.912071318934, 5903.114532820111, 5905.0, 3905.511811023622, 4026.2148880968225, 4027.0536423940353, 4033.7983100845136, 4074.327735923569, 6159.168512250879, 6221.097940798559, 6238.407351301665, 6239.001759718423, 6242.1261023456755, 4111.93089796655, 4116.58834116592, 4133.111381053088, 4134.028503301722, 4137.565555616678, 4199.958000420018, 4203.159368126387, 4207.663386929038, 4211.957880421218, 4212.831486740557, 4735.266033764772, 4844.031193761261, 4856.465788763233, 4865.172920603435, 4906.460289368167, 5849.385814489502, 5853.853653658693, 5858.355580886099, 5858.47273745365, 5882.588218824641, 1442.3725679329525, 1468.8310844253049, 1469.808924839764, 1473.0425223604743, 1474.4618214351685, 978.6427953796955, 990.2919412620012, 998.6205242007991, 1007.5113569918584, 1011.7318910488726, 5126.794928202905, 5137.2037334213255, 5140.228965655182, 5150.536451719363, 5164.251183578435, 6109.266887973472, 6109.450149486479, 6112.113743507167, 6122.806052819657, 6136.815895523141, 5120.61595380348, 5131.820386286462, 5131.846044618667, 5139.22911563261, 5149.819756308511, 3255.1497872887167, 3293.555370025064, 3310.668933106718, 3328.1346849818738, 3331.60020797501, 5714.542836573148, 5749.88500229993, 5779.24869766936, 5788.0, 5846.064629659234, 6340.778072767431, 6364.268109167412, 6370.076338930921, 6380.138681278061, 6382.329855365213, 5788.88422231553, 5837.3870743571315, 5839.124131380327, 5841.766329346863, 5852.561057920673, 6008.188894499362, 6120.663363515049, 6121.3572574879, 6147.231596050494, 6163.260408750979, 6057.4851137653795, 6057.606255593372, 6065.2418447694035, 6065.696715164312, 6069.484093852072, 5843.29880414353, 5846.064629659234, 5854.502367298827, 5857.707114644166, 5858.531317494675, 4144.150449157855, 4180.310248808913, 4180.728252663567, 4182.9581704182565, 4187.664986800988, 6033.87932241344, 6175.3515880831865, 6181.072839074175, 6190.350013248724, 6190.597611155261, 5889.087191485327, 5917.082852157922, 5918.585699001201, 5925.259342582177, 5929.258842644669, 5925.229720136354, 5938.851528711644, 5941.287045554561, 5947.791827286024, 5970.820875373745, 5631.0, 5760.1935728998815, 5783.624064435799, 5812.041013232769, 5818.185454036523, 5980.222571065734, 5986.2517185351835, 5991.011483105239, 5992.700364981821, 5995.16067750524, 5820.76716931318, 5826.766929322949, 5844.883102338014, 5845.269341332333, 5857.619254748428], "unit": "score", "name": "prototype.html", "value": 4402.276078942677}, {"lowerIsBetter": false, "replicates": [661.5898143151245, 720.8270015196352, 767.7197822794682, 773.5397438524079, 781.1212386065677, 11662.358570278631, 11791.823122653168, 11800.232984855978, 11841.348725820088, 11866.228695134821, 11455.541778328878, 11795.056395488362, 11804.527818887234, 11832.112591555624, 11837.46731397087, 804.3042768005677, 820.8030072782519, 822.8436597046572, 823.3948048184579, 841.7180244618061, 818.2717381530442, 819.397742659145, 820.6143112737004, 821.2362502872327, 827.383599218583, 861.3281640320529, 862.1249431826701, 864.6368525219423, 869.9217070463657, 870.9520976346298, 855.247382303572, 860.0281681699639, 862.784303924019, 863.5380071661663, 864.7794812322818, 630.136712703599, 641.0896526931768, 641.5669423139362, 641.8555824939398, 642.097852517214, 12258.264504129691, 12317.630471085882, 12329.753404931851, 12397.62807115788, 12413.131080824345, 10970.341779493256, 11166.050885674646, 11168.106551475863, 11241.494132764044, 11413.086953043736, 9458.9527052365, 9476.573554190078, 9482.431054136774, 9591.088846559636, 9612.951935240279, 3126.444092203277, 3185.1877771168433, 3219.0664707234873, 3240.91897702557, 3242.0760083376126, 40166.397504037464, 40635.593644063476, 40638.59361406407, 40667.7966610168, 40774.184516309804, 9060.0, 9164.358494905293, 9175.0, 9218.492982885871, 9459.24326053914, 15268.0, 15330.463433779763, 15368.538943831703, 15858.0, 15969.36122555108, 5862.736176872051, 5971.4327138921735, 5980.282366116094, 6009.489193418521, 6202.131701561785, 3480.0, 3518.665726755954, 3527.2416430467574, 3530.5763308402643, 3596.9100772480897, 2548.4011257354505, 2550.9107181248937, 2554.476332351863, 2556.258684981372, 2563.3335332813604, 476.41401076675885, 476.9546893045155, 478.4187212536784, 492.4386199732308, 494.71801073387826, 468.88746700791563, 487.27152906404444, 576.3602401334515, 576.7375843991058, 597.1460811040254, 7515.736949206752, 7558.962205188939, 7625.779875219938, 7698.692052317844, 7750.651220695082, 499.1439680947193, 536.4849744245568, 610.716017052073, 625.5902383938527, 628.9716962736687, 3669.3395188865725, 3942.8619998299923, 3975.1453437511072, 4001.459802926626, 4080.489938757655, 45999.0, 46148.30777538339, 46844.297335539995, 47140.76429617898, 47177.29234061492, 41919.79040104841, 43064.569354306055, 43114.353284700126, 43167.35248971268, 43389.0, 39141.60858391436, 39445.0, 39580.0, 40616.39075413871, 40774.1845163101, 7650.076680604062, 7872.685092596232, 7971.920280797118, 8053.476524025919, 8117.756467305991, 29277.41445171042, 30058.69941300559, 30147.849260753555, 30174.84912575423, 32153.196170094998, 37408.0, 37562.436563451025, 38073.619263807006, 38582.80708596439, 39222.60777392304, 9575.521223938636, 9850.655227067018, 10188.89811101909, 10194.184465242912, 10542.894571054192, 11041.00630943219, 11048.392338421463, 11170.609028683957, 11494.425278736197, 12025.218360806519, 10608.257421980386, 10730.463476825971, 10996.780064398827, 11138.164637652046, 11457.770844583229, 10482.0, 10567.682969510926, 10568.630097946534, 11067.833982490109, 11209.49557269941, 9776.511174441392, 10433.58265669395, 10489.685309440729, 10514.894851051391, 11001.339919604528, 9026.503542305236, 9037.638494460149, 9134.497602631918, 9296.349255552046, 9398.812023759623, 8900.955495222483, 9012.324075694218, 9154.221891139328, 9317.39436936597, 9474.0], "unit": "score", "name": "yui.html", "value": 5713.306028742004}], "name": "dromaeo_css", "value": 6296.768179240089}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 111.0, 114.0, 114.0, 115.0, 127.0, 114.0, 114.0, 114.0, 117.0], "unit": "score", "name": "ai-astar", "value": 115.6}, {"lowerIsBetter": true, "replicates": [157.0, 131.0, 156.0, 170.0, 138.0, 160.0, 154.0, 135.0, 174.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 150.6}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 165.0, 162.0, 171.0, 166.0, 167.0, 162.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.6}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 74.0, 76.0, 128.0, 74.0, 79.0, 79.0, 73.0, 92.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [94.0, 100.0, 138.0, 98.0, 96.0, 95.0, 134.0, 95.0, 95.0, 126.0], "unit": "score", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 121.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 111.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 76.0, 74.0, 77.0, 75.0, 77.0, 81.0, 75.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 75.7}, {"lowerIsBetter": true, "replicates": [78.0, 68.0, 69.0, 67.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 86.0, 96.0, 87.0, 85.0, 85.0, 88.0, 94.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [132.0, 134.0, 124.0, 134.0, 130.0, 122.0, 136.0, 125.0, 137.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.7}, {"lowerIsBetter": true, "replicates": [143.0, 150.0, 156.0, 160.0, 153.0, 144.0, 154.0, 152.0, 145.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.1}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 72.0, 73.0, 73.0, 72.0, 70.0, 71.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1558.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7570877369569], "unit": "score", "name": "Richards", "value": 210.43522200000004}, {"lowerIsBetter": false, "replicates": [187.6172607879925], "unit": "score", "name": "DeltaBlue", "value": 352.4089399999998}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5284.210526315789], "unit": "score", "name": "Decrypt", "value": 50.37289840637447}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [742.9420505200594], "unit": "score", "name": "Earley", "value": 897.0591980000003}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [27054.054054054053], "unit": "score", "name": "RegExp", "value": 33.67277222777225}, {"lowerIsBetter": false, "replicates": [594.1770647653001], "unit": "score", "name": "Splay", "value": 137.14935300000005}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21117.31966694228}]} 11:17:46 INFO - RETURN: dromaeo_css: 6296.77 11:17:46 INFO - RETURN: kraken: 1558.80 11:17:46 INFO - RETURN: v8_7: 21117.32 11:17:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21117.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1558.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6296.77"}}} 11:17:46 INFO - Return code: 0 11:17:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:17:46 INFO - # TBPL SUCCESS # 11:17:46 INFO - Running post-action listener: _resource_record_post_action 11:17:46 INFO - Running post-run listener: _resource_record_post_run 11:17:47 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 8192; Write bytes: 508051456; Read time: 24; Write time: 574040 11:17:47 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231563264; Read time: 0; Write time: 370392 11:17:47 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 8192; Write bytes: 276488192; Read time: 24; Write time: 203648 11:17:47 INFO - Running post-run listener: _upload_blobber_files 11:17:47 INFO - Blob upload gear active. 11:17:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:17:47 INFO - Copying logs to upload dir... 11:17:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.427992 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-16 11:17:47.472061) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:17:47.475830) ========= 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=6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009931 build_url: 'https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:17:47.528010) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:17:47.528505) ========= 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=6d5287d839824eebc594b0c9000001d1-1450291964.571614-395115916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:17:47.578200) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 11:17:47.578528) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 11:17:47.578838) ========= ========= Total master_lag: 0.24 =========