builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1449827193.39 results: success (0) buildid: 20151211010636 builduid: f7681e5db5c64b788d7f6309eee05507 revision: 06a9506d70b99f6220495e234f739b2f150f2600 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.386589) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.387002) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.387285) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006465 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.423801) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.424095) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.479608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.479917) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.530752) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.531370) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.532541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.532950) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 01:46: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% 63.4M=0s 2015-12-11 01:46:33 (63.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189467 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.735467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.735885) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017471 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.788341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:33.788745) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 06a9506d70b99f6220495e234f739b2f150f2600 --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 06a9506d70b99f6220495e234f739b2f150f2600 --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=23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 01:46:34,040 truncating revision to first 12 chars 2015-12-11 01:46:34,040 Setting DEBUG logging. 2015-12-11 01:46:34,040 attempt 1/10 2015-12-11 01:46:34,040 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/06a9506d70b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 01:46:34,303 unpacking tar archive at: fx-team-06a9506d70b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540755 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:34.345160) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:34.345924) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:34.357331) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:34.357741) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 01:46:34.358735) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-11 01:46:34.359515) ========= /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=23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:46:34 INFO - MultiFileLogger online at 20151211 01:46:34 in /builds/slave/test 01:46:34 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 01:46:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:46:34 INFO - {'append_to_log': False, 01:46:34 INFO - 'base_work_dir': '/builds/slave/test', 01:46:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:46:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:46:34 INFO - 'branch': 'Fx-Team-Non-PGO', 01:46:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:46:34 INFO - 'config_files': ('talos/linux_config.py',), 01:46:34 INFO - 'default_actions': ('clobber', 01:46:34 INFO - 'read-buildbot-config', 01:46:34 INFO - 'download-and-extract', 01:46:34 INFO - 'populate-webroot', 01:46:34 INFO - 'create-virtualenv', 01:46:34 INFO - 'install', 01:46:34 INFO - 'run-tests'), 01:46:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:46:34 INFO - 'download_minidump_stackwalk': True, 01:46:34 INFO - 'download_symbols': 'ondemand', 01:46:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:46:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:46:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:46:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:46:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:46:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:46:34 INFO - 'installer_path': 'installer.exe', 01:46:34 INFO - 'log_level': 'info', 01:46:34 INFO - 'log_name': 'talos', 01:46:34 INFO - 'log_to_console': True, 01:46:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:46:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:46:34 INFO - 'opt_config_files': (), 01:46:34 INFO - 'pip_index': False, 01:46:34 INFO - 'sps_profile': False, 01:46:34 INFO - 'sps_profile_interval': 0, 01:46:34 INFO - 'suite': 'dromaeojs-e10s', 01:46:34 INFO - 'system_bits': '64', 01:46:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:46:34 INFO - 'title': 'talos-linux64-ix-030', 01:46:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:46:34 INFO - 'use_talos_json': True, 01:46:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:46:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:46:34 INFO - 'work_dir': 'build'} 01:46:34 INFO - ##### 01:46:34 INFO - ##### Running clobber step. 01:46:34 INFO - ##### 01:46:34 INFO - Running pre-action listener: _resource_record_pre_action 01:46:34 INFO - Running main action method: clobber 01:46:34 INFO - rmtree: /builds/slave/test/build 01:46:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:46:35 INFO - Running post-action listener: _resource_record_post_action 01:46:35 INFO - ##### 01:46:35 INFO - ##### Running read-buildbot-config step. 01:46:35 INFO - ##### 01:46:35 INFO - Running pre-action listener: _resource_record_pre_action 01:46:35 INFO - Running main action method: read_buildbot_config 01:46:35 INFO - Using buildbot properties: 01:46:35 INFO - { 01:46:35 INFO - "properties": { 01:46:35 INFO - "buildnumber": 562, 01:46:35 INFO - "product": "firefox", 01:46:35 INFO - "script_repo_revision": "production", 01:46:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:46:35 INFO - "repository": "", 01:46:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:46:35 INFO - "buildid": "20151211010636", 01:46:35 INFO - "slavename": "talos-linux64-ix-030", 01:46:35 INFO - "pgo_build": "False", 01:46:35 INFO - "basedir": "/builds/slave/test", 01:46:35 INFO - "project": "", 01:46:35 INFO - "platform": "ubuntu64_hw", 01:46:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:46:35 INFO - "slavebuilddir": "test", 01:46:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:46:35 INFO - "branch": "fx-team", 01:46:35 INFO - "repo_path": "integration/fx-team", 01:46:35 INFO - "stage_platform": "linux64", 01:46:35 INFO - "builduid": "f7681e5db5c64b788d7f6309eee05507", 01:46:35 INFO - "revision": "06a9506d70b99f6220495e234f739b2f150f2600" 01:46:35 INFO - }, 01:46:35 INFO - "sourcestamp": { 01:46:35 INFO - "repository": "", 01:46:35 INFO - "hasPatch": false, 01:46:35 INFO - "project": "", 01:46:35 INFO - "branch": "fx-team-linux64-talos", 01:46:35 INFO - "changes": [ 01:46:35 INFO - { 01:46:35 INFO - "category": null, 01:46:35 INFO - "files": [ 01:46:35 INFO - { 01:46:35 INFO - "url": null, 01:46:35 INFO - "name": "https://queue.taskcluster.net/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 01:46:35 INFO - } 01:46:35 INFO - ], 01:46:35 INFO - "repository": "", 01:46:35 INFO - "rev": "06a9506d70b99f6220495e234f739b2f150f2600", 01:46:35 INFO - "who": "cbook@mozilla.com", 01:46:35 INFO - "when": 1449827100, 01:46:35 INFO - "number": 7318579, 01:46:35 INFO - "comments": "Bug 1215570 - Update the rooms context whenever the domain/tab changes whilst tab sharing. r=standard8", 01:46:35 INFO - "project": "", 01:46:35 INFO - "at": "Fri 11 Dec 2015 01:45:00", 01:46:35 INFO - "branch": "fx-team-linux64-talos", 01:46:35 INFO - "revlink": "", 01:46:35 INFO - "properties": [ 01:46:35 INFO - [ 01:46:35 INFO - "buildid", 01:46:35 INFO - "20151211010636", 01:46:35 INFO - "Change" 01:46:35 INFO - ], 01:46:35 INFO - [ 01:46:35 INFO - "builduid", 01:46:35 INFO - "f7681e5db5c64b788d7f6309eee05507", 01:46:35 INFO - "Change" 01:46:35 INFO - ], 01:46:35 INFO - [ 01:46:35 INFO - "pgo_build", 01:46:35 INFO - "False", 01:46:35 INFO - "Change" 01:46:35 INFO - ] 01:46:35 INFO - ], 01:46:35 INFO - "revision": "06a9506d70b99f6220495e234f739b2f150f2600" 01:46:35 INFO - } 01:46:35 INFO - ], 01:46:35 INFO - "revision": "06a9506d70b99f6220495e234f739b2f150f2600" 01:46:35 INFO - } 01:46:35 INFO - } 01:46:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 01:46:35 INFO - Running post-action listener: _resource_record_post_action 01:46:35 INFO - ##### 01:46:35 INFO - ##### Running download-and-extract step. 01:46:35 INFO - ##### 01:46:35 INFO - Running pre-action listener: _resource_record_pre_action 01:46:35 INFO - Running main action method: download_and_extract 01:46:35 INFO - mkdir: /builds/slave/test/build/tests 01:46:35 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')]} 01:46:35 INFO - https://queue.taskcluster.net/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:46:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/test_packages.json 01:46:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/test_packages.json 01:46:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:46:39 INFO - Downloaded 1302 bytes. 01:46:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:46:39 INFO - Using the following test package requirements: 01:46:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:46:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:46:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:39 INFO - u'jsshell-linux-x86_64.zip'], 01:46:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:46:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:46:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:46:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:46:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:46:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:46:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:46:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:39 INFO - https://queue.taskcluster.net/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:46:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:46:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:46:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:46:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:46:42 INFO - Downloaded 21867339 bytes. 01:46:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 01:46:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:46:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:46:43 INFO - Return code: 0 01:46:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:46:43 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')]} 01:46:43 INFO - https://queue.taskcluster.net/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:46:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:46:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:46:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:46:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:46:44 INFO - Downloaded 21867339 bytes. 01:46:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 01:46:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:46:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:46:46 INFO - Return code: 0 01:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:46 INFO - https://queue.taskcluster.net/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:46:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:46:47 INFO - Downloaded 11132038 bytes. 01:46:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 01:46:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 01:46:47 INFO - Return code: 0 01:46: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')]} 01:46:47 INFO - https://queue.taskcluster.net/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:46:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:46:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:46:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:46:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:46:49 INFO - Downloaded 57729473 bytes. 01:46:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:46:49 INFO - mkdir: /builds/slave/test/properties 01:46:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:46:49 INFO - Writing to file /builds/slave/test/properties/build_url 01:46:49 INFO - Contents: 01:46:49 INFO - build_url:https://queue.taskcluster.net/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:46:49 INFO - Running post-action listener: _resource_record_post_action 01:46:49 INFO - Running post-action listener: set_extra_try_arguments 01:46:49 INFO - ##### 01:46:49 INFO - ##### Running populate-webroot step. 01:46:49 INFO - ##### 01:46:49 INFO - Running pre-action listener: _resource_record_pre_action 01:46:49 INFO - Running main action method: populate_webroot 01:46:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:46:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:46:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:46:49 INFO - '--tppagecycles', 01:46:49 INFO - '7'], 01:46:49 INFO - 'tests': ['tsvgm']}}, 01:46:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:46:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:46:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:46:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:46:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:46:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:46:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:49 INFO - 'talos_options': ['--e10s'], 01:46:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:49 INFO - 'tests': ['damp', 'tps']}, 01:46:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:49 INFO - 'talos_options': ['--e10s'], 01:46:49 INFO - 'tests': ['damp', 'tps']}, 01:46:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:46:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:46:49 INFO - 'other': {'tests': ['a11yr', 01:46:49 INFO - 'ts_paint', 01:46:49 INFO - 'tpaint', 01:46:49 INFO - 'sessionrestore', 01:46:49 INFO - 'sessionrestore_no_auto_restore']}, 01:46:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:46:49 INFO - 'tests': ['a11yr', 01:46:49 INFO - 'ts_paint', 01:46:49 INFO - 'tpaint', 01:46:49 INFO - 'sessionrestore', 01:46:49 INFO - 'sessionrestore_no_auto_restore']}, 01:46:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:46:49 INFO - 'tests': ['a11yr', 01:46:49 INFO - 'ts_paint', 01:46:49 INFO - 'tpaint', 01:46:49 INFO - 'sessionrestore', 01:46:49 INFO - 'sessionrestore_no_auto_restore']}, 01:46:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:46:49 INFO - 'tests': ['a11yr', 01:46:49 INFO - 'ts_paint', 01:46:49 INFO - 'tpaint', 01:46:49 INFO - 'sessionrestore', 01:46:49 INFO - 'sessionrestore_no_auto_restore']}, 01:46:49 INFO - 'other_l64': {'tests': ['a11yr', 01:46:49 INFO - 'ts_paint', 01:46:49 INFO - 'tpaint', 01:46:49 INFO - 'sessionrestore', 01:46:49 INFO - 'sessionrestore_no_auto_restore']}, 01:46:49 INFO - 'other_nol64': {'tests': ['a11yr', 01:46:49 INFO - 'ts_paint', 01:46:49 INFO - 'tpaint', 01:46:49 INFO - 'sessionrestore', 01:46:49 INFO - 'sessionrestore_no_auto_restore']}, 01:46:49 INFO - 'svgr': {'tests': ['tsvgx', 01:46:49 INFO - 'tsvgr_opacity', 01:46:49 INFO - 'tart', 01:46:49 INFO - 'tscrollx', 01:46:49 INFO - 'cart']}, 01:46:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:46:49 INFO - 'tests': ['tsvgx', 01:46:49 INFO - 'tsvgr_opacity', 01:46:49 INFO - 'tart', 01:46:49 INFO - 'tscrollx', 01:46:49 INFO - 'cart']}, 01:46:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:49 INFO - 'tests': ['tp5o']}, 01:46:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:49 INFO - 'talos_options': ['--e10s'], 01:46:49 INFO - 'tests': ['tp5o']}, 01:46:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:49 INFO - 'talos_options': ['--xperf_path', 01:46:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:49 INFO - 'tests': ['tp5n']}, 01:46:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:49 INFO - 'talos_options': ['--e10s', 01:46:49 INFO - '--xperf_path', 01:46:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:49 INFO - 'tests': ['tp5n']}}, 01:46:49 INFO - 'talos.zip': {'path': '', 01:46:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:46:49 INFO - Running post-action listener: _resource_record_post_action 01:46:49 INFO - ##### 01:46:49 INFO - ##### Running create-virtualenv step. 01:46:49 INFO - ##### 01:46:49 INFO - Running pre-action listener: _resource_record_pre_action 01:46:49 INFO - Running main action method: create_virtualenv 01:46:49 INFO - Creating virtualenv /builds/slave/test/build/venv 01:46:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:46:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:46:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:46:49 INFO - Using real prefix '/usr' 01:46:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:46:50 INFO - Installing distribute.............................................................................................................................................................................................done. 01:46:52 INFO - Installing pip.................done. 01:46:52 INFO - Return code: 0 01:46:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62ccbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fa0b0>, '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 0x11fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fb440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', '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 01:46:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:46:52 INFO - Using env: {'DISPLAY': ':0', 01:46:52 INFO - 'HOME': '/home/cltbld', 01:46:52 INFO - 'LANG': 'en_US.UTF-8', 01:46:52 INFO - 'LANGUAGE': 'en_US:en', 01:46:52 INFO - 'LOGNAME': 'cltbld', 01:46:52 INFO - 'MAIL': '/var/mail/cltbld', 01:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:52 INFO - 'MOZ_NO_REMOTE': '1', 01:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:52 INFO - 'NO_EM_RESTART': '1', 01:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:52 INFO - 'PWD': '/builds/slave/test', 01:46:52 INFO - 'SHELL': '/bin/bash', 01:46:52 INFO - 'SHLVL': '1', 01:46:52 INFO - 'TERM': 'linux', 01:46:52 INFO - 'TMOUT': '86400', 01:46:52 INFO - 'USER': 'cltbld', 01:46:52 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', 01:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:52 INFO - '_': '/tools/buildbot/bin/python'} 01:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:52 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 01:46:52 INFO - Cleaning up... 01:46:52 INFO - Return code: 0 01:46:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff62ccbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fa0b0>, '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 0x11fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fb440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', '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 01:46:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:46:52 INFO - Using env: {'DISPLAY': ':0', 01:46:52 INFO - 'HOME': '/home/cltbld', 01:46:52 INFO - 'LANG': 'en_US.UTF-8', 01:46:52 INFO - 'LANGUAGE': 'en_US:en', 01:46:52 INFO - 'LOGNAME': 'cltbld', 01:46:52 INFO - 'MAIL': '/var/mail/cltbld', 01:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:52 INFO - 'MOZ_NO_REMOTE': '1', 01:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:52 INFO - 'NO_EM_RESTART': '1', 01:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:52 INFO - 'PWD': '/builds/slave/test', 01:46:52 INFO - 'SHELL': '/bin/bash', 01:46:52 INFO - 'SHLVL': '1', 01:46:52 INFO - 'TERM': 'linux', 01:46:52 INFO - 'TMOUT': '86400', 01:46:52 INFO - 'USER': 'cltbld', 01:46:52 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', 01:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:52 INFO - '_': '/tools/buildbot/bin/python'} 01:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:52 INFO - Downloading/unpacking psutil>=0.7.1 01:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:46:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:46:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:54 INFO - Installing collected packages: psutil 01:46:54 INFO - Running setup.py install for psutil 01:46:54 INFO - building 'psutil._psutil_linux' extension 01:46:54 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 01:46:54 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 01:46:54 INFO - building 'psutil._psutil_posix' extension 01:46:54 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 01:46:54 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 01:46:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:54 INFO - Successfully installed psutil 01:46:54 INFO - Cleaning up... 01:46:55 INFO - Return code: 0 01:46:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff62ccbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fa0b0>, '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 0x11fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fb440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', '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 01:46:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:46:55 INFO - Using env: {'DISPLAY': ':0', 01:46:55 INFO - 'HOME': '/home/cltbld', 01:46:55 INFO - 'LANG': 'en_US.UTF-8', 01:46:55 INFO - 'LANGUAGE': 'en_US:en', 01:46:55 INFO - 'LOGNAME': 'cltbld', 01:46:55 INFO - 'MAIL': '/var/mail/cltbld', 01:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:55 INFO - 'MOZ_NO_REMOTE': '1', 01:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:55 INFO - 'NO_EM_RESTART': '1', 01:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:55 INFO - 'PWD': '/builds/slave/test', 01:46:55 INFO - 'SHELL': '/bin/bash', 01:46:55 INFO - 'SHLVL': '1', 01:46:55 INFO - 'TERM': 'linux', 01:46:55 INFO - 'TMOUT': '86400', 01:46:55 INFO - 'USER': 'cltbld', 01:46:55 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', 01:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:55 INFO - '_': '/tools/buildbot/bin/python'} 01:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:46:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:46:56 INFO - Installing collected packages: mozsystemmonitor 01:46:56 INFO - Running setup.py install for mozsystemmonitor 01:46:57 INFO - Successfully installed mozsystemmonitor 01:46:57 INFO - Cleaning up... 01:46:57 INFO - Return code: 0 01:46:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:46: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')]} 01:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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')]} 01:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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', '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 0x7ff62ccbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fa0b0>, '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 0x11fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fb440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', '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 01:46: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:46: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 blobuploader==1.2.4 01:46:57 INFO - Using env: {'DISPLAY': ':0', 01:46:57 INFO - 'HOME': '/home/cltbld', 01:46:57 INFO - 'LANG': 'en_US.UTF-8', 01:46:57 INFO - 'LANGUAGE': 'en_US:en', 01:46:57 INFO - 'LOGNAME': 'cltbld', 01:46:57 INFO - 'MAIL': '/var/mail/cltbld', 01:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:57 INFO - 'MOZ_NO_REMOTE': '1', 01:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:57 INFO - 'NO_EM_RESTART': '1', 01:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:57 INFO - 'PWD': '/builds/slave/test', 01:46:57 INFO - 'SHELL': '/bin/bash', 01:46:57 INFO - 'SHLVL': '1', 01:46:57 INFO - 'TERM': 'linux', 01:46:57 INFO - 'TMOUT': '86400', 01:46:57 INFO - 'USER': 'cltbld', 01:46:57 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', 01:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:57 INFO - '_': '/tools/buildbot/bin/python'} 01:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:57 INFO - Downloading/unpacking blobuploader==1.2.4 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:58 INFO - Downloading blobuploader-1.2.4.tar.gz 01:46:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:46:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:46:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:59 INFO - Downloading docopt-0.6.1.tar.gz 01:46:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:46:59 INFO - Installing collected packages: blobuploader, requests, docopt 01:46:59 INFO - Running setup.py install for blobuploader 01:46:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:46:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:46:59 INFO - Running setup.py install for requests 01:47:00 INFO - Running setup.py install for docopt 01:47:00 INFO - Successfully installed blobuploader requests docopt 01:47:00 INFO - Cleaning up... 01:47:00 INFO - Return code: 0 01:47:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:00 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')]} 01:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:00 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')]} 01:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:00 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 0x7ff62ccbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fa0b0>, '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 0x11fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fb440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', '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 01:47:00 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 01:47:00 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 01:47:00 INFO - Using env: {'DISPLAY': ':0', 01:47:00 INFO - 'HOME': '/home/cltbld', 01:47:00 INFO - 'LANG': 'en_US.UTF-8', 01:47:00 INFO - 'LANGUAGE': 'en_US:en', 01:47:00 INFO - 'LOGNAME': 'cltbld', 01:47:00 INFO - 'MAIL': '/var/mail/cltbld', 01:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:00 INFO - 'MOZ_NO_REMOTE': '1', 01:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:00 INFO - 'NO_EM_RESTART': '1', 01:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:00 INFO - 'PWD': '/builds/slave/test', 01:47:00 INFO - 'SHELL': '/bin/bash', 01:47:00 INFO - 'SHLVL': '1', 01:47:00 INFO - 'TERM': 'linux', 01:47:00 INFO - 'TMOUT': '86400', 01:47:00 INFO - 'USER': 'cltbld', 01:47:00 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', 01:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:00 INFO - '_': '/tools/buildbot/bin/python'} 01:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:47:00 INFO - Running setup.py (path:/tmp/pip-2FbapP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:47:00 INFO - Running setup.py (path:/tmp/pip-ZXfTO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:47:00 INFO - Running setup.py (path:/tmp/pip-7x6ThW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:47:00 INFO - Running setup.py (path:/tmp/pip-hEf3vR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:47:00 INFO - Running setup.py (path:/tmp/pip-eycLqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:47:00 INFO - Running setup.py (path:/tmp/pip-_TZ_N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:47:00 INFO - Running setup.py (path:/tmp/pip-0Sloxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:47:01 INFO - Running setup.py (path:/tmp/pip-9w0jcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:47:01 INFO - Running setup.py (path:/tmp/pip-Wdbh2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:47:01 INFO - Running setup.py (path:/tmp/pip-euc4lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:47:01 INFO - Running setup.py (path:/tmp/pip-szFFDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:47:01 INFO - Running setup.py (path:/tmp/pip-tlKRgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:47:01 INFO - Running setup.py (path:/tmp/pip-DtYG7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:47:01 INFO - Running setup.py (path:/tmp/pip-SRJonJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:01 INFO - Running setup.py (path:/tmp/pip-6tJJ8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:47:01 INFO - Running setup.py (path:/tmp/pip-KC1pxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:47:01 INFO - Running setup.py (path:/tmp/pip-16e7w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:47:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:47:01 INFO - Running setup.py install for manifestparser 01:47:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:47:01 INFO - Running setup.py install for mozcrash 01:47:01 INFO - Running setup.py install for mozdebug 01:47:02 INFO - Running setup.py install for mozdevice 01:47:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Running setup.py install for mozfile 01:47:02 INFO - Running setup.py install for mozhttpd 01:47:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Running setup.py install for mozinfo 01:47:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Running setup.py install for mozInstall 01:47:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Running setup.py install for mozleak 01:47:02 INFO - Running setup.py install for mozlog 01:47:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Running setup.py install for moznetwork 01:47:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Running setup.py install for mozprocess 01:47:02 INFO - Running setup.py install for mozprofile 01:47:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:47:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:47:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:47:03 INFO - Running setup.py install for mozrunner 01:47:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:47:03 INFO - Running setup.py install for mozscreenshot 01:47:03 INFO - Running setup.py install for moztest 01:47:03 INFO - Running setup.py install for mozversion 01:47:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:47:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:47:03 INFO - Cleaning up... 01:47:03 INFO - Return code: 0 01:47:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ff62ccbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fa0b0>, '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 0x11fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fb440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', '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 01:47:03 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 01:47:03 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 01:47:03 INFO - Using env: {'DISPLAY': ':0', 01:47:03 INFO - 'HOME': '/home/cltbld', 01:47:03 INFO - 'LANG': 'en_US.UTF-8', 01:47:03 INFO - 'LANGUAGE': 'en_US:en', 01:47:03 INFO - 'LOGNAME': 'cltbld', 01:47:03 INFO - 'MAIL': '/var/mail/cltbld', 01:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:03 INFO - 'MOZ_NO_REMOTE': '1', 01:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:03 INFO - 'NO_EM_RESTART': '1', 01:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:03 INFO - 'PWD': '/builds/slave/test', 01:47:03 INFO - 'SHELL': '/bin/bash', 01:47:03 INFO - 'SHLVL': '1', 01:47:03 INFO - 'TERM': 'linux', 01:47:03 INFO - 'TMOUT': '86400', 01:47:03 INFO - 'USER': 'cltbld', 01:47:03 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', 01:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:03 INFO - '_': '/tools/buildbot/bin/python'} 01:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:47:03 INFO - Running setup.py (path:/tmp/pip-SEdt69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:47:03 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)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:47:03 INFO - Running setup.py (path:/tmp/pip-M76YNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:47:03 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)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:47:03 INFO - Running setup.py (path:/tmp/pip-ZyRPJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:47:03 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)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:47:03 INFO - Running setup.py (path:/tmp/pip-7XoOR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:47:03 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)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:47:03 INFO - Running setup.py (path:/tmp/pip-naYuqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:47:04 INFO - Running setup.py (path:/tmp/pip-iAiHpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:47:04 INFO - Running setup.py (path:/tmp/pip-AbZcvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:47:04 INFO - Running setup.py (path:/tmp/pip-c26AqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:47:04 INFO - Running setup.py (path:/tmp/pip-pGuc_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:47:04 INFO - Running setup.py (path:/tmp/pip-MOsD2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:47:04 INFO - Running setup.py (path:/tmp/pip-zfpOEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:47:04 INFO - Running setup.py (path:/tmp/pip-6QghcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:47:04 INFO - Running setup.py (path:/tmp/pip-zPkr53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:47:04 INFO - Running setup.py (path:/tmp/pip-43y6pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:04 INFO - Running setup.py (path:/tmp/pip-YUDe8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:47:04 INFO - Running setup.py (path:/tmp/pip-qQAeqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:47:04 INFO - Running setup.py (path:/tmp/pip-8aWNUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:47:04 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)) 01:47:04 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)) 01:47:04 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)) 01:47:04 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)) 01:47:04 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)) 01:47:04 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)) 01:47:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:06 INFO - Downloading blessings-1.5.1.tar.gz 01:47:06 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 01:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:47:06 INFO - Installing collected packages: blessings 01:47:06 INFO - Running setup.py install for blessings 01:47:06 INFO - Successfully installed blessings 01:47:06 INFO - Cleaning up... 01:47:06 INFO - Return code: 0 01:47:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:47:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:47:07 INFO - Reading from file tmpfile_stdout 01:47:07 INFO - Current package versions: 01:47:07 INFO - argparse == 1.2.1 01:47:07 INFO - blessings == 1.5.1 01:47:07 INFO - blobuploader == 1.2.4 01:47:07 INFO - docopt == 0.6.1 01:47:07 INFO - manifestparser == 1.1 01:47:07 INFO - mozInstall == 1.12 01:47:07 INFO - mozcrash == 0.16 01:47:07 INFO - mozdebug == 0.1 01:47:07 INFO - mozdevice == 0.47 01:47:07 INFO - mozfile == 1.2 01:47:07 INFO - mozhttpd == 0.7 01:47:07 INFO - mozinfo == 0.9 01:47:07 INFO - mozleak == 0.1 01:47:07 INFO - mozlog == 3.1 01:47:07 INFO - moznetwork == 0.27 01:47:07 INFO - mozprocess == 0.22 01:47:07 INFO - mozprofile == 0.27 01:47:07 INFO - mozrunner == 6.11 01:47:07 INFO - mozscreenshot == 0.1 01:47:07 INFO - mozsystemmonitor == 0.0 01:47:07 INFO - moztest == 0.7 01:47:07 INFO - mozversion == 1.4 01:47:07 INFO - psutil == 3.1.1 01:47:07 INFO - requests == 1.2.3 01:47:07 INFO - wsgiref == 0.1.2 01:47:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:07 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')]} 01:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:07 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')]} 01:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:07 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 0x7ff62ccbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fa0b0>, '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 0x11fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fb440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', '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 01:47:07 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 01:47:07 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 01:47:07 INFO - Using env: {'DISPLAY': ':0', 01:47:07 INFO - 'HOME': '/home/cltbld', 01:47:07 INFO - 'LANG': 'en_US.UTF-8', 01:47:07 INFO - 'LANGUAGE': 'en_US:en', 01:47:07 INFO - 'LOGNAME': 'cltbld', 01:47:07 INFO - 'MAIL': '/var/mail/cltbld', 01:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:07 INFO - 'MOZ_NO_REMOTE': '1', 01:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:07 INFO - 'NO_EM_RESTART': '1', 01:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:07 INFO - 'PWD': '/builds/slave/test', 01:47:07 INFO - 'SHELL': '/bin/bash', 01:47:07 INFO - 'SHLVL': '1', 01:47:07 INFO - 'TERM': 'linux', 01:47:07 INFO - 'TMOUT': '86400', 01:47:07 INFO - 'USER': 'cltbld', 01:47:07 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', 01:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:07 INFO - '_': '/tools/buildbot/bin/python'} 01:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:07 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)) 01:47:07 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)) 01:47:07 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)) 01:47:07 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)) 01:47:07 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)) 01:47:07 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)) 01:47:07 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)) 01:47:07 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)) 01:47: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:47:07 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)) 01:47:07 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)) 01:47:07 INFO - Cleaning up... 01:47:07 INFO - Return code: 0 01:47:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:47:07 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')]} 01:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:07 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')]} 01:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:07 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 0x7ff62ccbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fa0b0>, '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 0x11fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fb440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', '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 01:47:07 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 01:47:07 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 01:47:07 INFO - Using env: {'DISPLAY': ':0', 01:47:07 INFO - 'HOME': '/home/cltbld', 01:47:07 INFO - 'LANG': 'en_US.UTF-8', 01:47:07 INFO - 'LANGUAGE': 'en_US:en', 01:47:07 INFO - 'LOGNAME': 'cltbld', 01:47:07 INFO - 'MAIL': '/var/mail/cltbld', 01:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:07 INFO - 'MOZ_NO_REMOTE': '1', 01:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:07 INFO - 'NO_EM_RESTART': '1', 01:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:07 INFO - 'PWD': '/builds/slave/test', 01:47:07 INFO - 'SHELL': '/bin/bash', 01:47:07 INFO - 'SHLVL': '1', 01:47:07 INFO - 'TERM': 'linux', 01:47:07 INFO - 'TMOUT': '86400', 01:47:07 INFO - 'USER': 'cltbld', 01:47:07 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', 01:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:07 INFO - '_': '/tools/buildbot/bin/python'} 01:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:07 INFO - Downloading/unpacking jsonschema 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:47:09 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 01:47:09 INFO - Downloading/unpacking functools32 (from jsonschema) 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47:09 INFO - Downloading functools32-3.2.3-2.tar.gz 01:47:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:47:09 INFO - warning: no files found matching '*.txt' 01:47:09 INFO - no previously-included directories found matching 'build' 01:47:09 INFO - no previously-included directories found matching 'dist' 01:47:09 INFO - no previously-included directories found matching '.git*' 01:47:09 INFO - Installing collected packages: jsonschema, functools32 01:47:09 INFO - Running setup.py install for functools32 01:47:09 INFO - warning: no files found matching '*.txt' 01:47:09 INFO - no previously-included directories found matching 'build' 01:47:09 INFO - no previously-included directories found matching 'dist' 01:47:09 INFO - no previously-included directories found matching '.git*' 01:47:09 INFO - Successfully installed jsonschema functools32 01:47:09 INFO - Cleaning up... 01:47:09 INFO - Return code: 0 01:47:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:47: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')]} 01:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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')]} 01:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62ccbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116b240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fa0b0>, '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 0x11fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fb440>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', '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 01:47: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', 'flake8'] in /builds/slave/test/build 01:47: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 flake8 01:47:09 INFO - Using env: {'DISPLAY': ':0', 01:47:09 INFO - 'HOME': '/home/cltbld', 01:47:09 INFO - 'LANG': 'en_US.UTF-8', 01:47:09 INFO - 'LANGUAGE': 'en_US:en', 01:47:09 INFO - 'LOGNAME': 'cltbld', 01:47:09 INFO - 'MAIL': '/var/mail/cltbld', 01:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:09 INFO - 'MOZ_NO_REMOTE': '1', 01:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:09 INFO - 'NO_EM_RESTART': '1', 01:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:09 INFO - 'PWD': '/builds/slave/test', 01:47:09 INFO - 'SHELL': '/bin/bash', 01:47:09 INFO - 'SHLVL': '1', 01:47:09 INFO - 'TERM': 'linux', 01:47:09 INFO - 'TMOUT': '86400', 01:47:09 INFO - 'USER': 'cltbld', 01:47:09 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', 01:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:09 INFO - '_': '/tools/buildbot/bin/python'} 01:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:09 INFO - Downloading/unpacking flake8 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:47:11 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 01:47:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:47:11 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 01:47:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47:11 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 01:47:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:47:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:47:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:47:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:47:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:47:12 INFO - no previously-included directories found matching 'docs/_build' 01:47:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:47:12 INFO - Running setup.py install for pep8 01:47:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:47:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:47:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:47:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:47:12 INFO - no previously-included directories found matching 'docs/_build' 01:47:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:47:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:47:12 INFO - Cleaning up... 01:47:12 INFO - Return code: 0 01:47:12 INFO - Running post-action listener: _resource_record_post_action 01:47:12 INFO - Running post-action listener: _start_resource_monitoring 01:47:12 INFO - Starting resource monitoring. 01:47:12 INFO - ##### 01:47:12 INFO - ##### Running install step. 01:47:12 INFO - ##### 01:47:12 INFO - Running pre-action listener: _resource_record_pre_action 01:47:12 INFO - Running main action method: install 01:47:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:47:12 INFO - Reading from file tmpfile_stdout 01:47:12 INFO - Detecting whether we're running mozinstall >=1.0... 01:47:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:47:12 INFO - Reading from file tmpfile_stdout 01:47:12 INFO - Output received: 01:47:12 INFO - Usage: mozinstall [options] installer 01:47:12 INFO - Options: 01:47:12 INFO - -h, --help show this help message and exit 01:47:12 INFO - -d DEST, --destination=DEST 01:47:12 INFO - Directory to install application into. [default: 01:47:12 INFO - "/builds/slave/test"] 01:47:12 INFO - --app=APP Application being installed. [default: firefox] 01:47:12 INFO - mkdir: /builds/slave/test/build/application 01:47:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:47:27 INFO - Reading from file tmpfile_stdout 01:47:27 INFO - Output received: 01:47:27 INFO - /builds/slave/test/build/application/firefox/firefox 01:47:27 INFO - Running post-action listener: _resource_record_post_action 01:47:27 INFO - ##### 01:47:27 INFO - ##### Running run-tests step. 01:47:27 INFO - ##### 01:47:27 INFO - Running pre-action listener: _resource_record_pre_action 01:47:27 INFO - Running main action method: run_tests 01:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:47:27 INFO - Python 2.7.3 01:47:27 INFO - Return code: 0 01:47:27 INFO - grabbing minidump binary from tooltool 01:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:27 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 0x11fa0b0>, '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 0x11fafb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fb440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:47:27 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 01:47:27 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 01:47:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:47:27 INFO - Return code: 0 01:47:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:47:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:47:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:47:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:47:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:47:28 INFO - Return code: 0 01:47:28 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/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] in /builds/slave/test/build 01:47:28 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/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost 01:47:28 INFO - Using env: {'DISPLAY': ':0', 01:47:28 INFO - 'HOME': '/home/cltbld', 01:47:28 INFO - 'LANG': 'en_US.UTF-8', 01:47:28 INFO - 'LANGUAGE': 'en_US:en', 01:47:28 INFO - 'LOGNAME': 'cltbld', 01:47:28 INFO - 'MAIL': '/var/mail/cltbld', 01:47:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:47:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:28 INFO - 'MOZ_NO_REMOTE': '1', 01:47:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:28 INFO - 'NO_EM_RESTART': '1', 01:47:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:28 INFO - 'PWD': '/builds/slave/test', 01:47:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:47:28 INFO - 'SHELL': '/bin/bash', 01:47:28 INFO - 'SHLVL': '1', 01:47:28 INFO - 'TERM': 'linux', 01:47:28 INFO - 'TMOUT': '86400', 01:47:28 INFO - 'USER': 'cltbld', 01:47:28 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378', 01:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:28 INFO - '_': '/tools/buildbot/bin/python'} 01:47:28 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/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] with output_timeout 3600 01:47:28 INFO - mozversion INFO | application_buildid: 20151211010636 01:47:28 INFO - mozversion INFO | application_changeset: 06a9506d70b99f6220495e234f739b2f150f2600 01:47:28 INFO - mozversion INFO | application_display_name: Nightly 01:47:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:47:28 INFO - mozversion INFO | application_name: Firefox 01:47:28 INFO - mozversion INFO | application_remotingname: firefox 01:47:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 01:47:28 INFO - mozversion INFO | application_vendor: Mozilla 01:47:28 INFO - mozversion INFO | application_version: 45.0a1 01:47:28 INFO - mozversion INFO | platform_buildid: 20151211010636 01:47:28 INFO - mozversion INFO | platform_changeset: 06a9506d70b99f6220495e234f739b2f150f2600 01:47:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 01:47:28 INFO - mozversion INFO | platform_version: 45.0a1 01:47:28 INFO - 2015-12-11 01:47:28,534 DEBUG : using testdate: 1449827248 01:47:28 INFO - 2015-12-11 01:47:28,534 DEBUG : actual date: 1449827248 01:47:28 INFO - 2015-12-11 01:47:28,584 INFO : starting webserver on 'localhost:36811' 01:47:28 INFO - 2015-12-11 01:47:28,585 INFO : Starting test suite talos-linux64-ix-030.e 01:47:28 INFO - 2015-12-11 01:47:28,585 INFO : Starting test dromaeo_css 01:47:28 INFO - 2015-12-11 01:47:28,585 DEBUG : operating with platform_type : linux_ 01:47:28 INFO - 2015-12-11 01:47:28,586 INFO : Initialising browser for dromaeo_css test... 01:47:28 INFO - 2015-12-11 01:47:28,598 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTWatl0/profile http://localhost:36811/getInfo.html 01:47:33 INFO - 2015-12-11 01:47:33,673 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:47:33 INFO - 2015-12-11 01:47:33,674 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:47:33 INFO - 2015-12-11 01:47:33,674 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:47:33 INFO - 2015-12-11 01:47:33,674 DEBUG : BROWSER_OUTPUT: __metrics 01:47:33 INFO - 2015-12-11 01:47:33,798 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] 01:47:34 INFO - 2015-12-11 01:47:34,715 INFO : Browser initialized. 01:47:34 INFO - 2015-12-11 01:47:34,716 INFO : Running cycle 1/1 for dromaeo_css test... 01:47:34 INFO - 2015-12-11 01:47:34,716 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTWatl0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:47:46 INFO - 2015-12-11 01:47:46,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 143011840 01:47:46 INFO - 2015-12-11 01:47:46,807 DEBUG : BROWSER_OUTPUT: 01:48:36 INFO - 2015-12-11 01:48:36,451 DEBUG : BROWSER_OUTPUT: 1449827316448 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] 01:50:48 INFO - 2015-12-11 01:50:48,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36811/tests/dromaeo/cssquery-ext.html) 01:50:49 INFO - 2015-12-11 01:50:49,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 147496960 01:50:49 INFO - 2015-12-11 01:50:49,432 DEBUG : BROWSER_OUTPUT: 01:53:51 INFO - 2015-12-11 01:53:51,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/dromaeo/cssquery-ext.html (next: http://localhost:36811/tests/dromaeo/cssquery-jquery.html) 01:53:52 INFO - 2015-12-11 01:53:52,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 143814656 01:53:52 INFO - 2015-12-11 01:53:52,105 DEBUG : BROWSER_OUTPUT: 01:56:53 INFO - 2015-12-11 01:56:53,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36811/tests/dromaeo/cssquery-mootools.html) 01:56:54 INFO - 2015-12-11 01:56:54,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 145924096 01:56:54 INFO - 2015-12-11 01:56:54,489 DEBUG : BROWSER_OUTPUT: 01:59:56 INFO - 2015-12-11 01:59:56,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36811/tests/dromaeo/cssquery-prototype.html) 01:59:56 INFO - 2015-12-11 01:59:56,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 142786560 01:59:56 INFO - 2015-12-11 01:59:56,881 DEBUG : BROWSER_OUTPUT: 02:02:59 INFO - 2015-12-11 02:02:59,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36811/tests/dromaeo/cssquery-yui.html) 02:03:00 INFO - 2015-12-11 02:03:00,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 142979072 02:03:00 INFO - 2015-12-11 02:03:00,055 DEBUG : BROWSER_OUTPUT: 02:06:02 INFO - 2015-12-11 02:06:02,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/dromaeo/cssquery-yui.html (next: http://localhost:36811/tests/dromaeo/cssquery-dojo.html) 02:06:02 INFO - 2015-12-11 02:06:02,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 146743296 02:06:02 INFO - 2015-12-11 02:06:02,639 DEBUG : BROWSER_OUTPUT: 02:06:02 INFO - 2015-12-11 02:06:02,640 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:06:02 INFO - 2015-12-11 02:06:02,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:06:02 INFO - 2015-12-11 02:06:02,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:06:02 INFO - 2015-12-11 02:06:02,640 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:06:02 INFO - 2015-12-11 02:06:02,641 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2666.5466870631994;2696.7842572594195;2718.4019515706536;2736.808423410362;2741.3831887825236;4602.332661764042;4755.7622118894005;4759.809607615691;4775.068861571995;4800.543948324908;4713.387259656249;4758.785854636541;4783.880402989927;4861.343718597988;4875.975620121903;4335.848245311423;4385.51759306476;4442.800073996678;4470;4492.68551201416;4405.867823965286;4453.265211240157;4469.508354081048;4511.278195488722;4563.840265590705;4217.514985776645;4357.346398040288;4358;4433.135538569996;4453.53237910018;4368.191884501377;4383.320585309282;4480.641548676131;4484.529124441952;4521.344405061248;4385.3641222022625;4385.912281754347;4398.956010439887;4405.0969551241915;4443.977780111079;4542.295944128632;4588.678792484528;4645.88385290367;4672.4393072831135;4692.131955588227;5038.773255203525;5156.793728250866;5166.431692513858;5198.2722418861385;5226.503482169188;5119.56483698886;5121.359830021247;5136.04983078128;5142.768575414116;5192.4547922468355;4589.954100459019;4650.395448591729;4700.55344742249;4758.1673207188605;4763.190257656172;5278.049951008856;5290.127129023668;5303.018941495759;5305.734713264322;5308.0445519806035;5026.773795179226;5065.696058236517;5073.188289873602;5102.897942041139;5106.846794596168;4918.286848406961;5031.245313203049;5037;5161.329027226437;5190.792368305226;5016.824411145592;5034.597232221414;5054.898902021939;5065.164247899129;5110.565601923804;5043.117454445457;5053.36832895888;5053.46938571452;5056.393232812086;5058.544730974157;4095.140020595649;4156.376543518436;4206.72656277341;4210.726302790309;4237.512686041145;3686.760360576554;3699.79651119191;3707.258548290353;3734.290484807878;3736.5142531470733;4242.087951090531;4424.424824772759;4429.357743127229;4429.601335879786;4444.777761111932;5028.522290382408;5088.847334579968;5110.66780659256;5120.846374608767;5165.070287348238;4353.0423306872435;4358.978205109018;4389.473263208435;4389.561043895585;4412.779361031936;4286.914261714748;4377.8248870044845;4505.797239124247;4507.053518761031;4533.455985281787;4713.457952335457;4812.446568644651;4818.060478206856;4819.566239038503;4856.68431551955;5080.466551012239;5101.69389836611;5107.6169287302855;5120.539151476385;5142.074426603247;4587.885302867455;4696.906061878812;4734.73958932262;4825.758712064453;4876.951230487792;5110.770015349244;5118.283440318284;5128.3076784633595;5136.203888397305;5138.07514647367;5201.401838788436;5202.583793296451;5213.869653258547;5214.921776173436;5259.658122222043;4805.087033463631;4810.254410566367;4930.433000205022;4937.35814344133;5027.32131162303;4957;4958.1323268428605;4980.750962451935;4981.128302547112;4991.600671946163;4815;4870.4155501340065;4879.707217566957;4886.511348865085;4933.629977751755;4761.309610106446;4879.34128892595;4901.117798796251;4941.802327906844;4970.676906001098;4812.470628230822;4848.612111031039;4859.7327147005835;4873.512648735098;4893.975530122327 02:06:02 INFO - 2015-12-11 02:06:02,645 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.2030916099138;571.5656101362965;573.9267569644765;576.6684156609949;577.9337123008048;36950;37684.05789855251;37711.62288377115;37731.62268377319;37761;40145.59854401455;40577.18845623093;40602;40674.796626016905;40954.59045409552;7830.765077047683;7960.840783184332;8004.199580041978;8035.5580443075605;8055.113937466874;7870.685172593089;7966.203379662016;7967.60161991901;7969.840603187933;7973.362131029533;7889.171636978121;7970.242826931432;7988.201179882023;7997.680092796281;7999.320057795066;7910.485818421784;7920.881186782231;7926.088499822507;7958.721444749406;7964.840703185904;7827.569483678395;7903.841923161562;7928.286454219148;7931.9603401983195;7969.800754981172;37590.62409375926;38088;38108.23783524342;38156.61843381559;38211.808940955394;2965.569992351097;2985.5223164293825;3037.6051113355343;3302.8018318900704;3672.669459748609;28234.90969581754;28566.571501427494;28620.713792862014;29026;29420.8528957356;3461.7230621550466;3463.3073385323037;3531.0113168312914;3532.5231093802263;3554.4668299754985;212810;213528;213584;213945;214228;52772.73613631907;53898.730506347216;56121.43878561162;56391.43608563944;57495.425045749005;51188.74405627948;51357.22964155541;51411.742941285054;51513.22730159051;51550;12521.436535355748;12604.243745375306;12696.111272211041;12745.04412169091;12763.808542871864;9683.273754468442;9738.415695058318;9760.853587196198;9783.315167938319;9784.364016338915;18429.447116586525;19492.51268718265;19628.509287267934;19686.40940771779;19719.507012324808;7156.892646610305;7257;7361.742339018108;7365.410767138616;7400.777976660601;822.8683410654266;866.3545658484469;900.0792428569334;914.8216097860853;1053.210092430677;25992.35019124499;26241;26578;26585;26765.732342676325;942.8727121838601;948.6395169835419;971.8833739951251;979.2264111352094;986.2356673577891;13774.724505509834;13864.012605461165;14045.73588377051;14191.432342706175;14235;253187;255386;256222;256828.71585641953;257222;46261.53738462572;46491.302630460574;46543;46624.5337546627;46806;1166.8016437205695;1170.023030769317;1170.1574866096396;1170.7073231692077;1183.5029287699188;25278.873605631856;25333.240002799947;25596.360090997874;25598;25661.61507577425;40332;41015.589844101174;41015.589844101174;41077.38383924303;41108.58891411048;244190;245374;245487;245923;246235;28706;29190.41619167647;29239.269018274714;29261.85369073141;29363;33740.83129584434;33974.66025339715;34145.31709365749;34890.65109348874;34961.15427302944;31588.526172106976;31594.684053159173;32219.677803222607;32348;32486.675133248365;31836.204094897814;32096.358072837946;33348.499772502946;33799;34026.489602656475;29529.26176845596;29549.704502955556;29633.703662963093;29652.406951861274;29677.406451871273;25795.355116121496;27289.31776705598;27377.31556711098;27468;27486.862565687043;21784.673229901247;21969.890150549145;22012.229571964905;22013.449663758533;22022.669659954794 02:06:02 INFO - 2015-12-11 02:06:02,646 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.2412619857718;341.375283231686;342.0627480702875;342.2282752393353;343.4779135713717;15024.39902403904;15124.924375378121;15977.760333595006;15989;16458;10092.293539452223;10216.233782466308;10407.583696652126;10411.479426028705;10492.475376231196;4546.886327841806;4655.674102812804;4685;4686.765661716918;4696.154692155411;4837.274408838667;5141.305923700309;5153.484651534854;5163.199704045879;5183.688978661274;5146.845594632167;5150.098732721759;5429.701366424845;5590.916136257939;5609.439056094398;5084.923726144111;5569.693666848321;5573.749181286852;5580.246666700004;5603.691796951166;5062.291279220912;5063.26582645518;5070.29015937769;5073.036123136629;5091.592672586185;11850.644480665595;12220.755584888253;12228.327441990687;12236.143469957107;12236.265824050497;1774.7958984716793;1804.6571151481176;1821.6265665538533;1822.5443639090226;1866.6546688862468;9359.71920842369;9430.95284523573;9490.762730931712;9524.285678574135;9610.567524461347;1769.0889192066097;1771.1852547827887;1775.6359300476922;1857.9628407431776;1872.0265461959705;53414.93170136614;53614.195787063225;54088;56979.43020569783;57223.42776572264;9904.108630223314;9907.702768916944;10069.093781559548;10104.393736375694;10217.489125543692;12668.113232073667;12673.746525069448;12687.809682854764;12690.302033388067;12694.174878632859;6926.619035953071;6935.653217339112;6976.5814051157095;6992.755253566101;7044.6125463100025;6574;6584.078229047937;6612.371824676744;6622.205335359691;6634.933650663528;4253.255680255943;4254.085371645111;4266.125444283976;4275.957240427618;4285.721428107163;1748.6939785537734;1774.2370780564222;1797.334986055168;1809.719493478513;1850.9074546272632;813.6013353456882;857.6655104509247;878.6353663229816;987.2496902354262;1003.372891942536;15803.525894223192;15837;16123;16469.58826029359;16618.169091545617;805.1988271669609;830.0537387378394;842.3598065470287;854.9825707408164;876.8860048193694;9360.485173315534;9374.578143983537;9390.577424015799;9447.196988256075;9549.379290346105;455605;456212;458967;467031;467455;68673.65663171653;70888.64555677188;72537;73024.63487682528;73274.26725732781;972.9902700973041;978.9021097890296;983.9852402213972;986.7089208683456;1013.8884722680499;14562.922949659292;14654.706905861609;14729.410823566937;14786.186759727889;14855.257237137883;32144.19639509031;33004.83497582497;33194;33699;34595.48106778451;42299.365509518;42404.15191696087;43361.13277734491;44466.11067778562;44803.775981119885;8735.606897689491;9221.631134754534;9260.53697315118;9260.629574816932;9322.860157097513;10201.183905287411;10258.640947566799;10311.793764124826;10865.402402867601;16345;13484.932575337061;13533.120347177402;13749.656258593615;14093.929530352283;14258.71482570322;12809.359532023547;13345.933270333586;13350.933245333712;13474.393652285868;13692.178469291874;13047.934760326138;13349.66625834323;13634.181949083088;14141.787873181705;14210.360533775798;8905.421147625384;9073.727788166365;9086;9197.08029197075;9550.761230969281;14116;14136.717265654424;14237.430502779773;14322.570322889913;14755.704885902007 02:06:02 INFO - 2015-12-11 02:06:02,647 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1479.4895760962463;1561.828198898121;1565.8669013133883;1631.2577777111412;1710.2474911039142;5890.263717035371;6069.393060693928;6331.588446750958;6746.730130794768;6763.05317255584;6533.901991470132;6704.631245281507;6710.496712746552;6726.966365168168;6741;1986.3147214211074;2013.19472211116;2016.2741413091276;2020.1818263603263;2022.524706693933;1978.5251539630528;1984.1567333883115;2000.6398848207316;2021.0198053943825;2029.03620780129;2067.4727944374163;2085.103405535619;2092.748870135586;2098.9685154722692;2099.9055042523123;2116.47088227943;2132.976171437703;2134.6264403729365;2135.241989093865;2135.9893200533975;2061.1446249806313;2082.5834833033455;2093.6336141175234;2097.454661787931;2097.8216851567636;6917.9308206918295;6937.098177236978;6948.33990770881;6953.304669533057;6974.58152510851;4136.400221967798;4209.621134097946;4214.473190851144;4221.957780422187;4229.49246090468;2632.434026684272;2637.222019504251;2658.9734102658917;2750.972490275112;2754.600582915466;882.386741214856;886.1404437695425;887.5429153985702;905.7690288976269;920.6547544670749;9310.068993100704;9466.479343636098;9546;9578.233741300748;9592.856107158399;3873.922521549553;3885.9805700971315;3914.256291304643;3936.3505021671103;3945.349017412095;8399.370047246359;8427.578621068922;8428.072911979678;8428.620712067972;8443.366747493963;4247.341662042389;4252.170826688828;4259.595338442843;4260.723053001545;4261.531231564525;3745.8688945886765;3818.560865500503;3832.9808350958065;3834.3673293906195;3855.8072096395067;3231.6929891660257;3251.2034551535025;3270.7546933980047;3299.7360211183527;3322.4850148227065;990.6527123112561;995.8207522645848;1000.3697670467559;1000.6647772996128;1004.0862814838608;1125.9099272058215;1132.0151468222698;1179.8584169899666;1204.223275987001;1215.3315676378134;6594.604323740591;6805.6597170141295;6833.180018397824;6836.521443499007;6846.212685541127;915.6108653822099;933.500577191213;1066.8933106689424;1071.5820829876354;1085.766560189563;5192.221166824931;5289.841304760786;5305.920411193835;5343.812966546152;5363.436839131913;7994.960025199837;8305.37709671777;8430.283425908743;8483.915160848435;8505.532195729294;8104.594770261463;8115.634796434175;8119.350451963947;8167.101618822044;8172.877406838902;6728.259891411941;6782.898256526058;6786.423154031864;6821.965890170517;6852.588844669336;6313;6447.935520644921;6450.064740612679;6474.935250647433;6503.544751867324;7237.167725711611;7332.046833911558;7399.96300018518;7500.8499830002;7507.962460187664;7533.472656913963;7588.62056897164;7617.27635874591;7620.923790762243;7699.730509432143;5931.110333449845;6158.04550294705;6701.899471507833;6745.763898263734;6776.119104516381;6182.443580077815;6261.342559031236;6297.338779428094;6301.684915754286;6304.085907543289;6018.097285407224;6219.502439804714;6238.282597501164;6278.309385967448;6382.521310901794;5990.131430942576;6003.939960600513;6026.728797204224;6043.2748070231855;6261.405166509175;6193.194884664965;6229.2524897010835;6272.341404152681;6283.151774510566;6293.653849038164;5656.85857853557;5704.486596206361;5717.256756621613;5717.942820571741;5733.140028995684;5693.146028095819;5733.684647344269;5780.884382312414;5896.410358964069;5912.320083190316 02:06:02 INFO - 2015-12-11 02:06:02,649 DEBUG : BROWSER_OUTPUT: |4;prototype.html;313.7678118192537;317.6347200719173;323.3097337185112;325.6971016954233;327.1657273951424;5473.06957817171;5543.336998900324;5566.304211973504;5583.720813959301;5668.404817494165;5493.23094766733;5507.807226747064;5540.058190107681;5543.473370029851;5547.55619550436;4158.355454904479;4236.809343579546;4240.27915254406;4294.828206871722;4304.999999999992;4229.471316085489;4234.682398820086;4245.320748680197;4253.043065310296;4253.979045029187;4186.769727664977;4190.455240818689;4192.161567686459;4195.160967806436;4203.47456567929;4190.685698572604;4214.051838336396;4243.80902859369;4252.149570085995;4266.360045993095;3578.6958108560802;3687.115092377837;3730.7015438764834;3731.962680373216;3734.589195188527;5200.947990520122;5276;5284.867878303073;5287.23335116406;5316.12283973144;4825.276208568707;4882.658213925027;4888.266759986031;4888.291197776338;4888.926666099976;5803.593748437611;5833.270841144857;5845.532357411439;5854.18041474194;5857.85355366115;3943.9211215775813;4020.5175378954714;4034.132661477767;4034.293998550271;4035.9394609080887;6046.3349031606485;6105.542084343648;6112.3276439592055;6123.540734444934;6140.631562106243;4128.1330920507025;4133.586641335843;4136.8138433769955;4145.730527515701;4151.564085771011;4199.286121359315;4201.285781417167;4203.096334288081;4214.072903961123;4217.219814334358;4737.265723812815;4835.782389792468;4847.61219102478;4855.36880205571;4855.465898751135;5843.18195452637;5847.766089356463;5847.912281315784;5848.561357898089;5852.882942341129;1473.4106357456888;1493.6415260337442;1495.0655840099937;1495.200067963656;1495.364470100203;982.7199248214367;1004.9397036177853;1018.6231094495084;1023.1661196125134;1023.4064242739194;5056.191009438472;5070.264811602371;5074.923876141861;5080.263361812516;5080.669756465818;6029.60807547508;6045.214122164179;6057.3336932937345;6064.211652485149;6065.6663883486835;5043.646944713908;5054.09026375256;5058.772355244023;5059.468755780664;5063.088644044107;3200.647928727838;3251.024692592213;3257.267114899129;3274.9836250818594;3282.5404443377947;5625.409332020079;5682.289713785777;5689.9146512802345;5691.459311365414;5726.341470730836;6254.21822272216;6273.8745225095245;6284;6285.120083188357;6291.842703932347;5678.829635110953;5711.485966262973;5732.541396688255;5733.627314224562;5737.311522617312;5946.1972633693895;6047.334793172659;6053.182820319376;6078.483328917092;6092.147099406176;5936.762529498945;5943.524518038633;5951.523878089829;5951.583389162717;5977.342492325927;5700.230468886647;5708.828735137952;5713.400092990176;5718.628289161191;5730.054541000688;4137.524184718675;4191.371294305878;4195.706300558932;4201.432806571073;4212.326027835532;5875.73559189846;6016.217891674054;6036.094585811988;6077.058056001327;6097.725602347817;5788.421157884346;5867.061270196748;5872.1778950946045;5881.500072493886;5887.264091988502;5861.120831875082;5869.6771677558145;5873.882522349614;5874.500667443315;5879.588428809942;5613.57898157648;5698.287714035746;5720.799772007959;5723.31320241557;5737.454941780524;5871.94128058714;5878.500327472042;5889.617174883619;5895.174675545341;5900.675462849585;5742.454466825645;5745.224394706661;5752.223449834386;5758.539316854558;5767.452092051249 02:06:02 INFO - 2015-12-11 02:06:02,649 DEBUG : BROWSER_OUTPUT: |5;yui.html;655.1123228026024;730.1566690472505;767.761993781928;786.3984052200065;798.3214267872307;11344.092472602193;11399.088072954164;11427;11495.885041149575;11595.884041159587;11648.534058637666;11733.53065877364;11736.35450050247;11736.53053877846;11746.295222286648;627.6046090962687;632.2065807411692;802.5305196460064;807.7980504873782;827.8551253530638;821.9589020548979;822.8066404394963;827.4166712467696;828.0477450931447;829.0921441022101;864.4726716702806;868.6655637579546;868.9217970382664;874.1346067393298;874.64576846377;857.1471385970967;858.3862538285125;858.6050416808275;860.496609483453;860.7030574451804;629.9055141728732;636.8789929913348;638.7349250061219;642.5470043619238;643.1606753187089;12072.637820865388;12092.093093018058;12176.269423834598;12201.877981220163;12207.145499815017;10979.890201097967;11526.654200374001;11565.248258863146;11596.246243994114;11849.644510664608;9208.631654733803;9344.766380840465;9423.151916327495;9520.428774273565;9522.523873806282;3221.8389080546112;3246.8376581170846;3265.2979609384097;3356.8321583920706;3363.6972672459597;37764.99999999972;37799.43300850462;37830.62169378299;38041.80979095114;38134.23731525382;9141.308857861317;9336.766580835534;9337.439753614804;9642.276829237835;9721.854172187423;16803.41188058412;16811;16818.579535511464;16819.15904204785;16837.57906052334;6207.379262073847;6219.315875253718;6341.460975817107;6402.679866006681;6456;3462.117160124152;3589.120665436985;3596.7841929483793;3611;3631.673149416565;2492.6510288559616;2498.675172227599;2520.231329444537;2527.3176242414447;2530.430653103037;476.49729535339856;485.1752021563356;502.502522502727;503.04170555092605;520.7344254430268;379.4081233276043;388.6948745234977;471.2977663281754;476.59965628871913;500.9705056109657;6854.143232095988;7117.71529138839;7147.499675022803;7327.706891724378;7430.405567554582;452.1003203624763;514.951079647433;517.6764522173642;523.3013926408212;542.0108302348231;3427.640097789746;3450.3616830885862;3457.8098204598487;3561.3233485638166;3609.512715783388;49635.503644963814;49770.75114624476;50136;50293.24560131528;52703.73648131735;42677.57322426736;43658.56341436609;43688;43710;43843.78078109589;39575.208495829924;40251.19497610031;40410.595894041275;44189.77905110454;44571.77714111473;7528.698852045857;7563.621818909142;7816.452848300792;7936.603169841369;7981.920180798118;31029.534556982115;31368.05895823129;31451;31538.211544711565;31799.523007155374;35821;37519;39001.804990974866;39130.6086939127;39337;10342.586296548054;10393.9480302598;10460.63387781424;10485.895141048491;10740.83888741685;11050;11083.944580277048;11085.612003579836;11244.606438774603;11311.604093856675;9562.521873906138;9659.517024148623;9785.510724463891;9871.950640246752;10115.797684046425;10196.694099177037;10418.531166097695;10494.737631558966;10528.157747380037;10542.10392116648;9412.247020238228;9467.911190213214;9580.76048098803;9627.807443850943;9664.855027174739;9353.158215760614;9358.766030849283;9365.953170234105;9391.906080939103;9414.858777118487;8823.117688231383;9129.406588571721;9148.908510914805;9193;9416 02:06:02 INFO - 2015-12-11 02:06:02,649 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:06:02 INFO - 2015-12-11 02:06:02,649 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:06:02 INFO - 2015-12-11 02:06:02,649 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,332 02:06:02 INFO - 2015-12-11 02:06:02,649 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:06:02 INFO - 2015-12-11 02:06:02,649 DEBUG : BROWSER_OUTPUT: __startTimestamp1449828362638__endTimestamp 02:06:02 INFO - 2015-12-11 02:06:02,649 DEBUG : BROWSER_OUTPUT: 02:06:02 INFO - 2015-12-11 02:06:02,649 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:06:02 INFO - 2015-12-11 02:06:02,649 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:06:02 INFO - 2015-12-11 02:06:02,649 DEBUG : BROWSER_OUTPUT: 02:06:02 INFO - 2015-12-11 02:06:02,649 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4704.84 Median:4815.00 stddev:501.56 (10.4%) stddev-sans-first:476.93 02:06:02 INFO - 2015-12-11 02:06:02,651 DEBUG : BROWSER_OUTPUT: Values: 2666.5 2696.8 2718.4 2736.8 2741.4 4602.3 4755.8 4759.8 4775.1 4800.5 4713.4 4758.8 4783.9 4861.3 4876.0 4335.8 4385.5 4442.8 4470.0 4492.7 4405.9 4453.3 4469.5 4511.3 4563.8 4217.5 4357.3 4358.0 4433.1 4453.5 4368.2 4383.3 4480.6 4484.5 4521.3 4385.4 4385.9 4399.0 4405.1 4444.0 4542.3 4588.7 4645.9 4672.4 4692.1 5038.8 5156.8 5166.4 5198.3 5226.5 5119.6 5121.4 5136.0 5142.8 5192.5 4590.0 4650.4 4700.6 4758.2 4763.2 5278.0 5290.1 5303.0 5305.7 5308.0 5026.8 5065.7 5073.2 5102.9 5106.8 4918.3 5031.2 5037.0 5161.3 5190.8 5016.8 5034.6 5054.9 5065.2 5110.6 5043.1 5053.4 5053.5 5056.4 5058.5 4095.1 4156.4 4206.7 4210.7 4237.5 3686.8 3699.8 3707.3 3734.3 3736.5 4242.1 4424.4 4429.4 4429.6 4444.8 5028.5 5088.8 5110.7 5120.8 5165.1 4353.0 4359.0 4389.5 4389.6 4412.8 4286.9 4377.8 4505.8 4507.1 4533.5 4713.5 4812.4 4818.1 4819.6 4856.7 5080.5 5101.7 5107.6 5120.5 5142.1 4587.9 4696.9 4734.7 4825.8 4877.0 5110.8 5118.3 5128.3 5136.2 5138.1 5201.4 5202.6 5213.9 5214.9 5259.7 4805.1 4810.3 4930.4 4937.4 5027.3 4957.0 4958.1 4980.8 4981.1 4991.6 4815.0 4870.4 4879.7 4886.5 4933.6 4761.3 4879.3 4901.1 4941.8 4970.7 4812.5 4848.6 4859.7 4873.5 4894.0 02:06:02 INFO - 2015-12-11 02:06:02,651 DEBUG : BROWSER_OUTPUT: 02:06:02 INFO - 2015-12-11 02:06:02,651 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39620.44 Median:34925.90 stddev:62194.04 (178.1%) stddev-sans-first:62299.37 02:06:02 INFO - 2015-12-11 02:06:02,651 DEBUG : BROWSER_OUTPUT: Values: 561.2 571.6 573.9 576.7 577.9 36950.0 37684.1 37711.6 37731.6 37761.0 40145.6 40577.2 40602.0 40674.8 40954.6 7830.8 7960.8 8004.2 8035.6 8055.1 7870.7 7966.2 7967.6 7969.8 7973.4 7889.2 7970.2 7988.2 7997.7 7999.3 7910.5 7920.9 7926.1 7958.7 7964.8 7827.6 7903.8 7928.3 7932.0 7969.8 37590.6 38088.0 38108.2 38156.6 38211.8 2965.6 2985.5 3037.6 3302.8 3672.7 28234.9 28566.6 28620.7 29026.0 29420.9 3461.7 3463.3 3531.0 3532.5 3554.5 212810.0 213528.0 213584.0 213945.0 214228.0 52772.7 53898.7 56121.4 56391.4 57495.4 51188.7 51357.2 51411.7 51513.2 51550.0 12521.4 12604.2 12696.1 12745.0 12763.8 9683.3 9738.4 9760.9 9783.3 9784.4 18429.4 19492.5 19628.5 19686.4 19719.5 7156.9 7257.0 7361.7 7365.4 7400.8 822.9 866.4 900.1 914.8 1053.2 25992.4 26241.0 26578.0 26585.0 26765.7 942.9 948.6 971.9 979.2 986.2 13774.7 13864.0 14045.7 14191.4 14235.0 253187.0 255386.0 256222.0 256828.7 257222.0 46261.5 46491.3 46543.0 46624.5 46806.0 1166.8 1170.0 1170.2 1170.7 1183.5 25278.9 25333.2 25596.4 25598.0 25661.6 40332.0 41015.6 41015.6 41077.4 41108.6 244190.0 245374.0 245487.0 245923.0 246235.0 28706.0 29190.4 29239.3 29261.9 29363.0 33740.8 33974.7 34145.3 34890.7 34961.2 31588.5 31594.7 32219.7 32348.0 32486.7 31836.2 32096.4 33348.5 33799.0 34026.5 29529.3 29549.7 29633.7 29652.4 29677.4 25795.4 27289.3 27377.3 27468.0 27486.9 21784.7 21969.9 22012.2 22013.4 22022.7 02:06:02 INFO - 2015-12-11 02:06:02,651 DEBUG : BROWSER_OUTPUT: 02:06:02 INFO - 2015-12-11 02:06:02,651 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25344.80 Median:4280.84 stddev:75375.30 (1760.8%) stddev-sans-first:75563.37 02:06:02 INFO - 2015-12-11 02:06:02,652 DEBUG : BROWSER_OUTPUT: Values: 340.2 341.4 342.1 342.2 343.5 15024.4 15124.9 15977.8 15989.0 16458.0 10092.3 10216.2 10407.6 10411.5 10492.5 4546.9 4655.7 4685.0 4686.8 4696.2 4837.3 5141.3 5153.5 5163.2 5183.7 5146.8 5150.1 5429.7 5590.9 5609.4 5084.9 5569.7 5573.7 5580.2 5603.7 5062.3 5063.3 5070.3 5073.0 5091.6 11850.6 12220.8 12228.3 12236.1 12236.3 1774.8 1804.7 1821.6 1822.5 1866.7 9359.7 9431.0 9490.8 9524.3 9610.6 1769.1 1771.2 1775.6 1858.0 1872.0 53414.9 53614.2 54088.0 56979.4 57223.4 9904.1 9907.7 10069.1 10104.4 10217.5 12668.1 12673.7 12687.8 12690.3 12694.2 6926.6 6935.7 6976.6 6992.8 7044.6 6574.0 6584.1 6612.4 6622.2 6634.9 4253.3 4254.1 4266.1 4276.0 4285.7 1748.7 1774.2 1797.3 1809.7 1850.9 813.6 857.7 878.6 987.2 1003.4 15803.5 15837.0 16123.0 16469.6 16618.2 805.2 830.1 842.4 855.0 876.9 9360.5 9374.6 9390.6 9447.2 9549.4 455605.0 456212.0 458967.0 467031.0 467455.0 68673.7 70888.6 72537.0 73024.6 73274.3 973.0 978.9 984.0 986.7 1013.9 14562.9 14654.7 14729.4 14786.2 14855.3 32144.2 33004.8 33194.0 33699.0 34595.5 42299.4 42404.2 43361.1 44466.1 44803.8 8735.6 9221.6 9260.5 9260.6 9322.9 10201.2 10258.6 10311.8 10865.4 16345.0 13484.9 13533.1 13749.7 14093.9 14258.7 12809.4 13345.9 13350.9 13474.4 13692.2 13047.9 13349.7 13634.2 14141.8 14210.4 8905.4 9073.7 9086.0 9197.1 9550.8 14116.0 14136.7 14237.4 14322.6 14755.7 02:06:02 INFO - 2015-12-11 02:06:02,653 DEBUG : BROWSER_OUTPUT: 02:06:02 INFO - 2015-12-11 02:06:02,653 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4879.03 Median:6022.41 stddev:2488.96 (41.3%) stddev-sans-first:2482.82 02:06:02 INFO - 2015-12-11 02:06:02,653 DEBUG : BROWSER_OUTPUT: Values: 1479.5 1561.8 1565.9 1631.3 1710.2 5890.3 6069.4 6331.6 6746.7 6763.1 6533.9 6704.6 6710.5 6727.0 6741.0 1986.3 2013.2 2016.3 2020.2 2022.5 1978.5 1984.2 2000.6 2021.0 2029.0 2067.5 2085.1 2092.7 2099.0 2099.9 2116.5 2133.0 2134.6 2135.2 2136.0 2061.1 2082.6 2093.6 2097.5 2097.8 6917.9 6937.1 6948.3 6953.3 6974.6 4136.4 4209.6 4214.5 4222.0 4229.5 2632.4 2637.2 2659.0 2751.0 2754.6 882.4 886.1 887.5 905.8 920.7 9310.1 9466.5 9546.0 9578.2 9592.9 3873.9 3886.0 3914.3 3936.4 3945.3 8399.4 8427.6 8428.1 8428.6 8443.4 4247.3 4252.2 4259.6 4260.7 4261.5 3745.9 3818.6 3833.0 3834.4 3855.8 3231.7 3251.2 3270.8 3299.7 3322.5 990.7 995.8 1000.4 1000.7 1004.1 1125.9 1132.0 1179.9 1204.2 1215.3 6594.6 6805.7 6833.2 6836.5 6846.2 915.6 933.5 1066.9 1071.6 1085.8 5192.2 5289.8 5305.9 5343.8 5363.4 7995.0 8305.4 8430.3 8483.9 8505.5 8104.6 8115.6 8119.4 8167.1 8172.9 6728.3 6782.9 6786.4 6822.0 6852.6 6313.0 6447.9 6450.1 6474.9 6503.5 7237.2 7332.0 7400.0 7500.8 7508.0 7533.5 7588.6 7617.3 7620.9 7699.7 5931.1 6158.0 6701.9 6745.8 6776.1 6182.4 6261.3 6297.3 6301.7 6304.1 6018.1 6219.5 6238.3 6278.3 6382.5 5990.1 6003.9 6026.7 6043.3 6261.4 6193.2 6229.3 6272.3 6283.2 6293.7 5656.9 5704.5 5717.3 5717.9 5733.1 5693.1 5733.7 5780.9 5896.4 5912.3 02:06:02 INFO - 2015-12-11 02:06:02,653 DEBUG : BROWSER_OUTPUT: 02:06:02 INFO - 2015-12-11 02:06:02,654 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4826.51 Median:5500.52 stddev:1429.89 (26.0%) stddev-sans-first:1393.20 02:06:02 INFO - 2015-12-11 02:06:02,654 DEBUG : BROWSER_OUTPUT: Values: 313.8 317.6 323.3 325.7 327.2 5473.1 5543.3 5566.3 5583.7 5668.4 5493.2 5507.8 5540.1 5543.5 5547.6 4158.4 4236.8 4240.3 4294.8 4305.0 4229.5 4234.7 4245.3 4253.0 4254.0 4186.8 4190.5 4192.2 4195.2 4203.5 4190.7 4214.1 4243.8 4252.1 4266.4 3578.7 3687.1 3730.7 3732.0 3734.6 5200.9 5276.0 5284.9 5287.2 5316.1 4825.3 4882.7 4888.3 4888.3 4888.9 5803.6 5833.3 5845.5 5854.2 5857.9 3943.9 4020.5 4034.1 4034.3 4035.9 6046.3 6105.5 6112.3 6123.5 6140.6 4128.1 4133.6 4136.8 4145.7 4151.6 4199.3 4201.3 4203.1 4214.1 4217.2 4737.3 4835.8 4847.6 4855.4 4855.5 5843.2 5847.8 5847.9 5848.6 5852.9 1473.4 1493.6 1495.1 1495.2 1495.4 982.7 1004.9 1018.6 1023.2 1023.4 5056.2 5070.3 5074.9 5080.3 5080.7 6029.6 6045.2 6057.3 6064.2 6065.7 5043.6 5054.1 5058.8 5059.5 5063.1 3200.6 3251.0 3257.3 3275.0 3282.5 5625.4 5682.3 5689.9 5691.5 5726.3 6254.2 6273.9 6284.0 6285.1 6291.8 5678.8 5711.5 5732.5 5733.6 5737.3 5946.2 6047.3 6053.2 6078.5 6092.1 5936.8 5943.5 5951.5 5951.6 5977.3 5700.2 5708.8 5713.4 5718.6 5730.1 4137.5 4191.4 4195.7 4201.4 4212.3 5875.7 6016.2 6036.1 6077.1 6097.7 5788.4 5867.1 5872.2 5881.5 5887.3 5861.1 5869.7 5873.9 5874.5 5879.6 5613.6 5698.3 5720.8 5723.3 5737.5 5871.9 5878.5 5889.6 5895.2 5900.7 5742.5 5745.2 5752.2 5758.5 5767.5 02:06:02 INFO - 2015-12-11 02:06:02,654 DEBUG : BROWSER_OUTPUT: 02:06:02 INFO - 2015-12-11 02:06:02,654 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12112.42 Median:476.55 stddev:13690.36 (2872.8%) stddev-sans-first:13701.72 02:06:02 INFO - 2015-12-11 02:06:02,655 DEBUG : BROWSER_OUTPUT: Values: 655.1 730.2 767.8 786.4 798.3 11344.1 11399.1 11427.0 11495.9 11595.9 11648.5 11733.5 11736.4 11736.5 11746.3 627.6 632.2 802.5 807.8 827.9 822.0 822.8 827.4 828.0 829.1 864.5 868.7 868.9 874.1 874.6 857.1 858.4 858.6 860.5 860.7 629.9 636.9 638.7 642.5 643.2 12072.6 12092.1 12176.3 12201.9 12207.1 10979.9 11526.7 11565.2 11596.2 11849.6 9208.6 9344.8 9423.2 9520.4 9522.5 3221.8 3246.8 3265.3 3356.8 3363.7 37765.0 37799.4 37830.6 38041.8 38134.2 9141.3 9336.8 9337.4 9642.3 9721.9 16803.4 16811.0 16818.6 16819.2 16837.6 6207.4 6219.3 6341.5 6402.7 6456.0 3462.1 3589.1 3596.8 3611.0 3631.7 2492.7 2498.7 2520.2 2527.3 2530.4 476.5 485.2 502.5 503.0 520.7 379.4 388.7 471.3 476.6 501.0 6854.1 7117.7 7147.5 7327.7 7430.4 452.1 515.0 517.7 523.3 542.0 3427.6 3450.4 3457.8 3561.3 3609.5 49635.5 49770.8 50136.0 50293.2 52703.7 42677.6 43658.6 43688.0 43710.0 43843.8 39575.2 40251.2 40410.6 44189.8 44571.8 7528.7 7563.6 7816.5 7936.6 7981.9 31029.5 31368.1 31451.0 31538.2 31799.5 35821.0 37519.0 39001.8 39130.6 39337.0 10342.6 10393.9 10460.6 10485.9 10740.8 11050.0 11083.9 11085.6 11244.6 11311.6 9562.5 9659.5 9785.5 9872.0 10115.8 10196.7 10418.5 10494.7 10528.2 10542.1 9412.2 9467.9 9580.8 9627.8 9664.9 9353.2 9358.8 9366.0 9391.9 9414.9 8823.1 9129.4 9148.9 9193.0 9416.0 02:06:02 INFO - 2015-12-11 02:06:02,655 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:06:02 INFO - 2015-12-11 02:06:02,655 DEBUG : BROWSER_OUTPUT: 02:06:03 INFO - 2015-12-11 02:06:03,403 INFO : Browser exited with error code: 0 02:06:03 INFO - 2015-12-11 02:06:03,422 INFO : Completed test dromaeo_css (00:18:34) 02:06:03 INFO - 2015-12-11 02:06:03,422 INFO : Starting test kraken 02:06:03 INFO - 2015-12-11 02:06:03,422 DEBUG : operating with platform_type : linux_ 02:06:03 INFO - 2015-12-11 02:06:03,422 INFO : Initialising browser for kraken test... 02:06:03 INFO - 2015-12-11 02:06:03,428 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTBo77J/profile http://localhost:36811/getInfo.html 02:06:08 INFO - 2015-12-11 02:06:08,497 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:06:08 INFO - 2015-12-11 02:06:08,497 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:06:08 INFO - 2015-12-11 02:06:08,497 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:06:08 INFO - 2015-12-11 02:06:08,497 DEBUG : BROWSER_OUTPUT: __metrics 02:06:08 INFO - 2015-12-11 02:06:08,614 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] 02:06:09 INFO - 2015-12-11 02:06:09,515 INFO : Browser initialized. 02:06:09 INFO - 2015-12-11 02:06:09,516 INFO : Running cycle 1/1 for kraken test... 02:06:09 INFO - 2015-12-11 02:06:09,516 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTBo77J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:06:21 INFO - 2015-12-11 02:06:21,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 142909440 02:06:21 INFO - 2015-12-11 02:06:21,575 DEBUG : BROWSER_OUTPUT: 02:06:24 INFO - 2015-12-11 02:06:24,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36811/tests/kraken/driver.html?testName=audio-beat-detection) 02:06:24 INFO - 2015-12-11 02:06:24,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 142524416 02:06:24 INFO - 2015-12-11 02:06:24,776 DEBUG : BROWSER_OUTPUT: 02:06:27 INFO - 2015-12-11 02:06:27,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36811/tests/kraken/driver.html?testName=audio-dft) 02:06:28 INFO - 2015-12-11 02:06:28,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 142774272 02:06:28 INFO - 2015-12-11 02:06:28,100 DEBUG : BROWSER_OUTPUT: 02:06:30 INFO - 2015-12-11 02:06:30,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36811/tests/kraken/driver.html?testName=audio-fft) 02:06:31 INFO - 2015-12-11 02:06:31,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 137502720 02:06:31 INFO - 2015-12-11 02:06:31,584 DEBUG : BROWSER_OUTPUT: 02:06:33 INFO - 2015-12-11 02:06:33,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36811/tests/kraken/driver.html?testName=audio-oscillator) 02:06:34 INFO - 2015-12-11 02:06:34,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 139169792 02:06:34 INFO - 2015-12-11 02:06:34,287 DEBUG : BROWSER_OUTPUT: 02:06:36 INFO - 2015-12-11 02:06:36,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36811/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:06:37 INFO - 2015-12-11 02:06:37,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 140316672 02:06:37 INFO - 2015-12-11 02:06:37,135 DEBUG : BROWSER_OUTPUT: 02:06:40 INFO - 2015-12-11 02:06:40,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36811/tests/kraken/driver.html?testName=imaging-darkroom) 02:06:40 INFO - 2015-12-11 02:06:40,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 139423744 02:06:40 INFO - 2015-12-11 02:06:40,768 DEBUG : BROWSER_OUTPUT: 02:06:44 INFO - 2015-12-11 02:06:44,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36811/tests/kraken/driver.html?testName=imaging-desaturate) 02:06:44 INFO - 2015-12-11 02:06:44,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 137887744 02:06:44 INFO - 2015-12-11 02:06:44,877 DEBUG : BROWSER_OUTPUT: 02:06:47 INFO - 2015-12-11 02:06:47,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36811/tests/kraken/driver.html?testName=json-parse-financial) 02:06:48 INFO - 2015-12-11 02:06:48,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 137289728 02:06:48 INFO - 2015-12-11 02:06:48,409 DEBUG : BROWSER_OUTPUT: 02:06:50 INFO - 2015-12-11 02:06:50,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36811/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:06:50 INFO - 2015-12-11 02:06:50,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 140525568 02:06:50 INFO - 2015-12-11 02:06:50,764 DEBUG : BROWSER_OUTPUT: 02:06:52 INFO - 2015-12-11 02:06:52,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36811/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:06:53 INFO - 2015-12-11 02:06:53,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 140783616 02:06:53 INFO - 2015-12-11 02:06:53,277 DEBUG : BROWSER_OUTPUT: 02:06:55 INFO - 2015-12-11 02:06:55,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36811/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:06:56 INFO - 2015-12-11 02:06:56,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 140660736 02:06:56 INFO - 2015-12-11 02:06:56,009 DEBUG : BROWSER_OUTPUT: 02:06:58 INFO - 2015-12-11 02:06:58,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:06:59 INFO - 2015-12-11 02:06:59,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 141336576 02:06:59 INFO - 2015-12-11 02:06:59,191 DEBUG : BROWSER_OUTPUT: 02:07:01 INFO - 2015-12-11 02:07:01,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:07:02 INFO - 2015-12-11 02:07:02,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 139059200 02:07:02 INFO - 2015-12-11 02:07:02,372 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36811/tests/kraken/driver.html?testName=ai-astar) 02:07:04 INFO - 2015-12-11 02:07:04,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 140668928 02:07:04 INFO - 2015-12-11 02:07:04,379 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,379 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:07:04 INFO - 2015-12-11 02:07:04,379 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:07:04 INFO - 2015-12-11 02:07:04,379 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:07:04 INFO - 2015-12-11 02:07:04,379 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:07:04 INFO - 2015-12-11 02:07:04,379 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;109;113;113;112;127;111;115;112;113 02:07:04 INFO - 2015-12-11 02:07:04,379 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;132;157;163;132;156;149;131;168;131 02:07:04 INFO - 2015-12-11 02:07:04,379 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;162;164;166;162;165;173;162;164;164 02:07:04 INFO - 2015-12-11 02:07:04,379 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;72;73;74;158;73;73;73;73;152 02:07:04 INFO - 2015-12-11 02:07:04,379 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;94;95;96;135;96;95;130 02:07:04 INFO - 2015-12-11 02:07:04,379 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;111;110;110;110;110;110 02:07:04 INFO - 2015-12-11 02:07:04,380 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;146;149;147;147;148;148;151;148 02:07:04 INFO - 2015-12-11 02:07:04,380 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;96;96;96;95;96;96;96 02:07:04 INFO - 2015-12-11 02:07:04,380 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;78;75;74;76;76;78;80;72;73 02:07:04 INFO - 2015-12-11 02:07:04,380 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;68;69;68;69;67;67;68 02:07:04 INFO - 2015-12-11 02:07:04,380 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;83;86;84;94;85;85;94;100 02:07:04 INFO - 2015-12-11 02:07:04,380 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;125;134;123;135;128;122;127;127;127 02:07:04 INFO - 2015-12-11 02:07:04,380 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;148;148;145;158;135;147;149;152;135 02:07:04 INFO - 2015-12-11 02:07:04,380 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;71;72;71;73;69;69;72;68 02:07:04 INFO - 2015-12-11 02:07:04,380 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:07:04 INFO - 2015-12-11 02:07:04,380 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:07:04 INFO - 2015-12-11 02:07:04,380 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,775 02:07:04 INFO - 2015-12-11 02:07:04,380 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: __startTimestamp1449828424374__endTimestamp 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.80 Median:113.00 stddev:4.89 (4.3%) stddev-sans-first:5.18 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: Values: 113.0 109.0 113.0 113.0 112.0 127.0 111.0 115.0 112.0 113.0 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.20 Median:156.50 stddev:15.22 (9.7%) stddev-sans-first:15.17 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: Values: 163.0 132.0 157.0 163.0 132.0 156.0 149.0 131.0 168.0 131.0 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:3.23 (2.0%) stddev-sans-first:3.43 02:07:04 INFO - 2015-12-11 02:07:04,381 DEBUG : BROWSER_OUTPUT: Values: 165.0 162.0 164.0 166.0 162.0 165.0 173.0 162.0 164.0 164.0 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.60 Median:73.00 stddev:34.51 (47.3%) stddev-sans-first:36.19 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: Values: 75.0 72.0 73.0 74.0 158.0 73.0 73.0 73.0 73.0 152.0 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:95.00 stddev:17.86 (18.8%) stddev-sans-first:18.47 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 94.0 95.0 96.0 135.0 96.0 95.0 130.0 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.41 (1.0%) stddev-sans-first:1.45 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 146.0 149.0 147.0 147.0 148.0 148.0 151.0 148.0 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,382 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.60 Median:76.00 stddev:2.50 (3.3%) stddev-sans-first:2.59 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: Values: 74.0 78.0 75.0 74.0 76.0 76.0 78.0 80.0 72.0 73.0 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 68.0 69.0 68.0 69.0 67.0 67.0 68.0 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:85.00 stddev:6.17 (7.3%) stddev-sans-first:6.06 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 83.0 86.0 84.0 94.0 85.0 85.0 94.0 100.0 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:127.00 stddev:4.97 (3.9%) stddev-sans-first:4.42 02:07:04 INFO - 2015-12-11 02:07:04,383 DEBUG : BROWSER_OUTPUT: Values: 119.0 125.0 134.0 123.0 135.0 128.0 122.0 127.0 127.0 127.0 02:07:04 INFO - 2015-12-11 02:07:04,384 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,384 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:148.00 stddev:7.72 (5.2%) stddev-sans-first:7.42 02:07:04 INFO - 2015-12-11 02:07:04,384 DEBUG : BROWSER_OUTPUT: Values: 136.0 148.0 148.0 145.0 158.0 135.0 147.0 149.0 152.0 135.0 02:07:04 INFO - 2015-12-11 02:07:04,384 DEBUG : BROWSER_OUTPUT: 02:07:04 INFO - 2015-12-11 02:07:04,384 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:1.58 (2.2%) stddev-sans-first:1.67 02:07:04 INFO - 2015-12-11 02:07:04,384 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 72.0 71.0 73.0 69.0 69.0 72.0 68.0 02:07:04 INFO - 2015-12-11 02:07:04,384 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:07:04 INFO - 2015-12-11 02:07:04,384 DEBUG : BROWSER_OUTPUT: 02:07:05 INFO - 2015-12-11 02:07:05,343 INFO : Browser exited with error code: 0 02:07:05 INFO - 2015-12-11 02:07:05,398 INFO : Completed test kraken (00:01:01) 02:07:05 INFO - 2015-12-11 02:07:05,398 INFO : Starting test v8_7 02:07:05 INFO - 2015-12-11 02:07:05,398 DEBUG : operating with platform_type : linux_ 02:07:05 INFO - 2015-12-11 02:07:05,398 INFO : Initialising browser for v8_7 test... 02:07:05 INFO - 2015-12-11 02:07:05,404 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptTNXFx/profile http://localhost:36811/getInfo.html 02:07:10 INFO - 2015-12-11 02:07:10,298 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:07:10 INFO - 2015-12-11 02:07:10,298 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:07:10 INFO - 2015-12-11 02:07:10,298 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:07:10 INFO - 2015-12-11 02:07:10,298 DEBUG : BROWSER_OUTPUT: __metrics 02:07:10 INFO - 2015-12-11 02:07:10,423 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] 02:07:11 INFO - 2015-12-11 02:07:11,395 INFO : Browser initialized. 02:07:11 INFO - 2015-12-11 02:07:11,396 INFO : Running cycle 1/1 for v8_7 test... 02:07:11 INFO - 2015-12-11 02:07:11,396 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptTNXFx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:07:23 INFO - 2015-12-11 02:07:23,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 142995456 02:07:23 INFO - 2015-12-11 02:07:23,425 DEBUG : BROWSER_OUTPUT: 02:07:44 INFO - 2015-12-11 02:07:44,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36811/tests/v8_7/run.html (next: http://localhost:36811/tests/v8_7/run.html) 02:07:45 INFO - 2015-12-11 02:07:45,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 138366976 02:07:45 INFO - 2015-12-11 02:07:45,122 DEBUG : BROWSER_OUTPUT: 02:07:45 INFO - 2015-12-11 02:07:45,122 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:07:45 INFO - 2015-12-11 02:07:45,123 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:07:45 INFO - 2015-12-11 02:07:45,123 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:07:45 INFO - 2015-12-11 02:07:45,123 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:07:45 INFO - 2015-12-11 02:07:45,123 DEBUG : BROWSER_OUTPUT: |0;Richards;167.16817118020728 02:07:45 INFO - 2015-12-11 02:07:45,123 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.84288354898337 02:07:45 INFO - 2015-12-11 02:07:45,123 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.623542476402 02:07:45 INFO - 2015-12-11 02:07:45,123 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 02:07:45 INFO - 2015-12-11 02:07:45,124 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1044.932079414838 02:07:45 INFO - 2015-12-11 02:07:45,124 DEBUG : BROWSER_OUTPUT: |5;Earley;744.6016381236038 02:07:45 INFO - 2015-12-11 02:07:45,124 DEBUG : BROWSER_OUTPUT: |6;Boyer;11988.095238095239 02:07:45 INFO - 2015-12-11 02:07:45,124 DEBUG : BROWSER_OUTPUT: |7;RegExp;27054.054054054053 02:07:45 INFO - 2015-12-11 02:07:45,124 DEBUG : BROWSER_OUTPUT: |8;Splay;596.6587112171837 02:07:45 INFO - 2015-12-11 02:07:45,124 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 02:07:45 INFO - 2015-12-11 02:07:45,124 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:07:45 INFO - 2015-12-11 02:07:45,124 DEBUG : BROWSER_OUTPUT: __startTimestamp1449828465115__endTimestamp 02:07:45 INFO - 2015-12-11 02:07:45,125 DEBUG : BROWSER_OUTPUT: 02:07:45 INFO - 2015-12-11 02:07:45,125 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:07:45 INFO - 2015-12-11 02:07:45,125 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:07:45 INFO - 2015-12-11 02:07:45,125 DEBUG : BROWSER_OUTPUT: 02:07:45 INFO - 2015-12-11 02:07:45,125 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 02:07:45 INFO - 2015-12-11 02:07:45,125 DEBUG : BROWSER_OUTPUT: Values: 167.2 02:07:45 INFO - 2015-12-11 02:07:45,125 DEBUG : BROWSER_OUTPUT: 02:07:45 INFO - 2015-12-11 02:07:45,126 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.84 Median:184.84 stddev:0.00 (0.0%) 02:07:45 INFO - 2015-12-11 02:07:45,126 DEBUG : BROWSER_OUTPUT: Values: 184.8 02:07:45 INFO - 2015-12-11 02:07:45,126 DEBUG : BROWSER_OUTPUT: 02:07:45 INFO - 2015-12-11 02:07:45,126 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.62 Median:277.62 stddev:0.00 (0.0%) 02:07:45 INFO - 2015-12-11 02:07:45,126 DEBUG : BROWSER_OUTPUT: Values: 277.6 02:07:45 INFO - 2015-12-11 02:07:45,126 DEBUG : BROWSER_OUTPUT: 02:07:45 INFO - 2015-12-11 02:07:45,126 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 02:07:45 INFO - 2015-12-11 02:07:45,126 DEBUG : BROWSER_OUTPUT: Values: 5181.3 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1044.93 Median:1044.93 stddev:0.00 (0.0%) 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: Values: 1044.9 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:744.60 Median:744.60 stddev:0.00 (0.0%) 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: Values: 744.6 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11988.10 Median:11988.10 stddev:0.00 (0.0%) 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: Values: 11988.1 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27054.05 Median:27054.05 stddev:0.00 (0.0%) 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: Values: 27054.1 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: 02:07:45 INFO - 2015-12-11 02:07:45,127 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:596.66 Median:596.66 stddev:0.00 (0.0%) 02:07:45 INFO - 2015-12-11 02:07:45,128 DEBUG : BROWSER_OUTPUT: Values: 596.7 02:07:45 INFO - 2015-12-11 02:07:45,128 DEBUG : BROWSER_OUTPUT: 02:07:45 INFO - 2015-12-11 02:07:45,128 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 02:07:45 INFO - 2015-12-11 02:07:45,128 DEBUG : BROWSER_OUTPUT: Values: 4830.9 02:07:45 INFO - 2015-12-11 02:07:45,128 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:07:45 INFO - 2015-12-11 02:07:45,128 DEBUG : BROWSER_OUTPUT: 02:07:46 INFO - 2015-12-11 02:07:46,051 INFO : Browser exited with error code: 0 02:07:46 INFO - 2015-12-11 02:07:46,066 INFO : Completed test v8_7 (00:00:40) 02:07:46 INFO - 2015-12-11 02:07:46,144 INFO : Completed test suite (00:20:17) 02:07:46 INFO - 2015-12-11 02:07:46,144 DEBUG : Working with test: dromaeo_css 02:07:46 INFO - 2015-12-11 02:07:46,144 DEBUG : Generating results file: dromaeo_css 02:07:46 INFO - 2015-12-11 02:07:46,145 DEBUG : Working with test: kraken 02:07:46 INFO - 2015-12-11 02:07:46,146 DEBUG : Generating results file: kraken 02:07:46 INFO - 2015-12-11 02:07:46,146 INFO : javascript benchmark 02:07:46 INFO - 2015-12-11 02:07:46,146 DEBUG : Working with test: v8_7 02:07:46 INFO - 2015-12-11 02:07:46,146 DEBUG : Generating results file: v8_7 02:07:46 INFO - 2015-12-11 02:07:46,146 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:07:46 INFO - 2015-12-11 02:07:46,208 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 02:07:46 INFO - 2015-12-11 02:07:46,208 DEBUG : process_Request line: dromaeo_css 6297.79 graph.html#tests=[[72,132,43]] 02:07:46 INFO - 2015-12-11 02:07:46,209 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:07:46 INFO - 2015-12-11 02:07:46,243 DEBUG : process_Request line: kraken 1549.80 graph.html#tests=[[232,132,43]] 02:07:46 INFO - 2015-12-11 02:07:46,243 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:07:46 INFO - 2015-12-11 02:07:46,276 DEBUG : process_Request line: v8_7 21308.78 graph.html#tests=[[230,132,43]] 02:07:46 INFO - 2015-12-11 02:07:46,277 INFO : javascript benchmark 02:07:46 INFO - 2015-12-11 02:07:46,281 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2666.5466870631994, 2696.7842572594195, 2718.4019515706536, 2736.808423410362, 2741.3831887825236, 4602.332661764042, 4755.7622118894005, 4759.809607615691, 4775.068861571995, 4800.543948324908, 4713.387259656249, 4758.785854636541, 4783.880402989927, 4861.343718597988, 4875.975620121903, 4335.848245311423, 4385.51759306476, 4442.800073996678, 4470.0, 4492.68551201416, 4405.867823965286, 4453.265211240157, 4469.508354081048, 4511.278195488722, 4563.840265590705, 4217.514985776645, 4357.346398040288, 4358.0, 4433.135538569996, 4453.53237910018, 4368.191884501377, 4383.320585309282, 4480.641548676131, 4484.529124441952, 4521.344405061248, 4385.3641222022625, 4385.912281754347, 4398.956010439887, 4405.0969551241915, 4443.977780111079, 4542.295944128632, 4588.678792484528, 4645.88385290367, 4672.4393072831135, 4692.131955588227, 5038.773255203525, 5156.793728250866, 5166.431692513858, 5198.2722418861385, 5226.503482169188, 5119.56483698886, 5121.359830021247, 5136.04983078128, 5142.768575414116, 5192.4547922468355, 4589.954100459019, 4650.395448591729, 4700.55344742249, 4758.1673207188605, 4763.190257656172, 5278.049951008856, 5290.127129023668, 5303.018941495759, 5305.734713264322, 5308.0445519806035, 5026.773795179226, 5065.696058236517, 5073.188289873602, 5102.897942041139, 5106.846794596168, 4918.286848406961, 5031.245313203049, 5037.0, 5161.329027226437, 5190.792368305226, 5016.824411145592, 5034.597232221414, 5054.898902021939, 5065.164247899129, 5110.565601923804, 5043.117454445457, 5053.36832895888, 5053.46938571452, 5056.393232812086, 5058.544730974157, 4095.140020595649, 4156.376543518436, 4206.72656277341, 4210.726302790309, 4237.512686041145, 3686.760360576554, 3699.79651119191, 3707.258548290353, 3734.290484807878, 3736.5142531470733, 4242.087951090531, 4424.424824772759, 4429.357743127229, 4429.601335879786, 4444.777761111932, 5028.522290382408, 5088.847334579968, 5110.66780659256, 5120.846374608767, 5165.070287348238, 4353.0423306872435, 4358.978205109018, 4389.473263208435, 4389.561043895585, 4412.779361031936, 4286.914261714748, 4377.8248870044845, 4505.797239124247, 4507.053518761031, 4533.455985281787, 4713.457952335457, 4812.446568644651, 4818.060478206856, 4819.566239038503, 4856.68431551955, 5080.466551012239, 5101.69389836611, 5107.6169287302855, 5120.539151476385, 5142.074426603247, 4587.885302867455, 4696.906061878812, 4734.73958932262, 4825.758712064453, 4876.951230487792, 5110.770015349244, 5118.283440318284, 5128.3076784633595, 5136.203888397305, 5138.07514647367, 5201.401838788436, 5202.583793296451, 5213.869653258547, 5214.921776173436, 5259.658122222043, 4805.087033463631, 4810.254410566367, 4930.433000205022, 4937.35814344133, 5027.32131162303, 4957.0, 4958.1323268428605, 4980.750962451935, 4981.128302547112, 4991.600671946163, 4815.0, 4870.4155501340065, 4879.707217566957, 4886.511348865085, 4933.629977751755, 4761.309610106446, 4879.34128892595, 4901.117798796251, 4941.802327906844, 4970.676906001098, 4812.470628230822, 4848.612111031039, 4859.7327147005835, 4873.512648735098, 4893.975530122327], "unit": "ms", "name": "dojo.html", "value": 4673.047979337757}, {"lowerIsBetter": false, "replicates": [561.2030916099138, 571.5656101362965, 573.9267569644765, 576.6684156609949, 577.9337123008048, 36950.0, 37684.05789855251, 37711.62288377115, 37731.62268377319, 37761.0, 40145.59854401455, 40577.18845623093, 40602.0, 40674.796626016905, 40954.59045409552, 7830.765077047683, 7960.840783184332, 8004.199580041978, 8035.5580443075605, 8055.113937466874, 7870.685172593089, 7966.203379662016, 7967.60161991901, 7969.840603187933, 7973.362131029533, 7889.171636978121, 7970.242826931432, 7988.201179882023, 7997.680092796281, 7999.320057795066, 7910.485818421784, 7920.881186782231, 7926.088499822507, 7958.721444749406, 7964.840703185904, 7827.569483678395, 7903.841923161562, 7928.286454219148, 7931.9603401983195, 7969.800754981172, 37590.62409375926, 38088.0, 38108.23783524342, 38156.61843381559, 38211.808940955394, 2965.569992351097, 2985.5223164293825, 3037.6051113355343, 3302.8018318900704, 3672.669459748609, 28234.90969581754, 28566.571501427494, 28620.713792862014, 29026.0, 29420.8528957356, 3461.7230621550466, 3463.3073385323037, 3531.0113168312914, 3532.5231093802263, 3554.4668299754985, 212810.0, 213528.0, 213584.0, 213945.0, 214228.0, 52772.73613631907, 53898.730506347216, 56121.43878561162, 56391.43608563944, 57495.425045749005, 51188.74405627948, 51357.22964155541, 51411.742941285054, 51513.22730159051, 51550.0, 12521.436535355748, 12604.243745375306, 12696.111272211041, 12745.04412169091, 12763.808542871864, 9683.273754468442, 9738.415695058318, 9760.853587196198, 9783.315167938319, 9784.364016338915, 18429.447116586525, 19492.51268718265, 19628.509287267934, 19686.40940771779, 19719.507012324808, 7156.892646610305, 7257.0, 7361.742339018108, 7365.410767138616, 7400.777976660601, 822.8683410654266, 866.3545658484469, 900.0792428569334, 914.8216097860853, 1053.210092430677, 25992.35019124499, 26241.0, 26578.0, 26585.0, 26765.732342676325, 942.8727121838601, 948.6395169835419, 971.8833739951251, 979.2264111352094, 986.2356673577891, 13774.724505509834, 13864.012605461165, 14045.73588377051, 14191.432342706175, 14235.0, 253187.0, 255386.0, 256222.0, 256828.71585641953, 257222.0, 46261.53738462572, 46491.302630460574, 46543.0, 46624.5337546627, 46806.0, 1166.8016437205695, 1170.023030769317, 1170.1574866096396, 1170.7073231692077, 1183.5029287699188, 25278.873605631856, 25333.240002799947, 25596.360090997874, 25598.0, 25661.61507577425, 40332.0, 41015.589844101174, 41015.589844101174, 41077.38383924303, 41108.58891411048, 244190.0, 245374.0, 245487.0, 245923.0, 246235.0, 28706.0, 29190.41619167647, 29239.269018274714, 29261.85369073141, 29363.0, 33740.83129584434, 33974.66025339715, 34145.31709365749, 34890.65109348874, 34961.15427302944, 31588.526172106976, 31594.684053159173, 32219.677803222607, 32348.0, 32486.675133248365, 31836.204094897814, 32096.358072837946, 33348.499772502946, 33799.0, 34026.489602656475, 29529.26176845596, 29549.704502955556, 29633.703662963093, 29652.406951861274, 29677.406451871273, 25795.355116121496, 27289.31776705598, 27377.31556711098, 27468.0, 27486.862565687043, 21784.673229901247, 21969.890150549145, 22012.229571964905, 22013.449663758533, 22022.669659954794], "unit": "ms", "name": "ext.html", "value": 16571.419862479877}, {"lowerIsBetter": false, "replicates": [340.2412619857718, 341.375283231686, 342.0627480702875, 342.2282752393353, 343.4779135713717, 15024.39902403904, 15124.924375378121, 15977.760333595006, 15989.0, 16458.0, 10092.293539452223, 10216.233782466308, 10407.583696652126, 10411.479426028705, 10492.475376231196, 4546.886327841806, 4655.674102812804, 4685.0, 4686.765661716918, 4696.154692155411, 4837.274408838667, 5141.305923700309, 5153.484651534854, 5163.199704045879, 5183.688978661274, 5146.845594632167, 5150.098732721759, 5429.701366424845, 5590.916136257939, 5609.439056094398, 5084.923726144111, 5569.693666848321, 5573.749181286852, 5580.246666700004, 5603.691796951166, 5062.291279220912, 5063.26582645518, 5070.29015937769, 5073.036123136629, 5091.592672586185, 11850.644480665595, 12220.755584888253, 12228.327441990687, 12236.143469957107, 12236.265824050497, 1774.7958984716793, 1804.6571151481176, 1821.6265665538533, 1822.5443639090226, 1866.6546688862468, 9359.71920842369, 9430.95284523573, 9490.762730931712, 9524.285678574135, 9610.567524461347, 1769.0889192066097, 1771.1852547827887, 1775.6359300476922, 1857.9628407431776, 1872.0265461959705, 53414.93170136614, 53614.195787063225, 54088.0, 56979.43020569783, 57223.42776572264, 9904.108630223314, 9907.702768916944, 10069.093781559548, 10104.393736375694, 10217.489125543692, 12668.113232073667, 12673.746525069448, 12687.809682854764, 12690.302033388067, 12694.174878632859, 6926.619035953071, 6935.653217339112, 6976.5814051157095, 6992.755253566101, 7044.6125463100025, 6574.0, 6584.078229047937, 6612.371824676744, 6622.205335359691, 6634.933650663528, 4253.255680255943, 4254.085371645111, 4266.125444283976, 4275.957240427618, 4285.721428107163, 1748.6939785537734, 1774.2370780564222, 1797.334986055168, 1809.719493478513, 1850.9074546272632, 813.6013353456882, 857.6655104509247, 878.6353663229816, 987.2496902354262, 1003.372891942536, 15803.525894223192, 15837.0, 16123.0, 16469.58826029359, 16618.169091545617, 805.1988271669609, 830.0537387378394, 842.3598065470287, 854.9825707408164, 876.8860048193694, 9360.485173315534, 9374.578143983537, 9390.577424015799, 9447.196988256075, 9549.379290346105, 455605.0, 456212.0, 458967.0, 467031.0, 467455.0, 68673.65663171653, 70888.64555677188, 72537.0, 73024.63487682528, 73274.26725732781, 972.9902700973041, 978.9021097890296, 983.9852402213972, 986.7089208683456, 1013.8884722680499, 14562.922949659292, 14654.706905861609, 14729.410823566937, 14786.186759727889, 14855.257237137883, 32144.19639509031, 33004.83497582497, 33194.0, 33699.0, 34595.48106778451, 42299.365509518, 42404.15191696087, 43361.13277734491, 44466.11067778562, 44803.775981119885, 8735.606897689491, 9221.631134754534, 9260.53697315118, 9260.629574816932, 9322.860157097513, 10201.183905287411, 10258.640947566799, 10311.793764124826, 10865.402402867601, 16345.0, 13484.932575337061, 13533.120347177402, 13749.656258593615, 14093.929530352283, 14258.71482570322, 12809.359532023547, 13345.933270333586, 13350.933245333712, 13474.393652285868, 13692.178469291874, 13047.934760326138, 13349.66625834323, 13634.181949083088, 14141.787873181705, 14210.360533775798, 8905.421147625384, 9073.727788166365, 9086.0, 9197.08029197075, 9550.761230969281, 14116.0, 14136.717265654424, 14237.430502779773, 14322.570322889913, 14755.704885902007], "unit": "ms", "name": "jquery.html", "value": 8109.692592612253}, {"lowerIsBetter": false, "replicates": [1479.4895760962463, 1561.828198898121, 1565.8669013133883, 1631.2577777111412, 1710.2474911039142, 5890.263717035371, 6069.393060693928, 6331.588446750958, 6746.730130794768, 6763.05317255584, 6533.901991470132, 6704.631245281507, 6710.496712746552, 6726.966365168168, 6741.0, 1986.3147214211074, 2013.19472211116, 2016.2741413091276, 2020.1818263603263, 2022.524706693933, 1978.5251539630528, 1984.1567333883115, 2000.6398848207316, 2021.0198053943825, 2029.03620780129, 2067.4727944374163, 2085.103405535619, 2092.748870135586, 2098.9685154722692, 2099.9055042523123, 2116.47088227943, 2132.976171437703, 2134.6264403729365, 2135.241989093865, 2135.9893200533975, 2061.1446249806313, 2082.5834833033455, 2093.6336141175234, 2097.454661787931, 2097.8216851567636, 6917.9308206918295, 6937.098177236978, 6948.33990770881, 6953.304669533057, 6974.58152510851, 4136.400221967798, 4209.621134097946, 4214.473190851144, 4221.957780422187, 4229.49246090468, 2632.434026684272, 2637.222019504251, 2658.9734102658917, 2750.972490275112, 2754.600582915466, 882.386741214856, 886.1404437695425, 887.5429153985702, 905.7690288976269, 920.6547544670749, 9310.068993100704, 9466.479343636098, 9546.0, 9578.233741300748, 9592.856107158399, 3873.922521549553, 3885.9805700971315, 3914.256291304643, 3936.3505021671103, 3945.349017412095, 8399.370047246359, 8427.578621068922, 8428.072911979678, 8428.620712067972, 8443.366747493963, 4247.341662042389, 4252.170826688828, 4259.595338442843, 4260.723053001545, 4261.531231564525, 3745.8688945886765, 3818.560865500503, 3832.9808350958065, 3834.3673293906195, 3855.8072096395067, 3231.6929891660257, 3251.2034551535025, 3270.7546933980047, 3299.7360211183527, 3322.4850148227065, 990.6527123112561, 995.8207522645848, 1000.3697670467559, 1000.6647772996128, 1004.0862814838608, 1125.9099272058215, 1132.0151468222698, 1179.8584169899666, 1204.223275987001, 1215.3315676378134, 6594.604323740591, 6805.6597170141295, 6833.180018397824, 6836.521443499007, 6846.212685541127, 915.6108653822099, 933.500577191213, 1066.8933106689424, 1071.5820829876354, 1085.766560189563, 5192.221166824931, 5289.841304760786, 5305.920411193835, 5343.812966546152, 5363.436839131913, 7994.960025199837, 8305.37709671777, 8430.283425908743, 8483.915160848435, 8505.532195729294, 8104.594770261463, 8115.634796434175, 8119.350451963947, 8167.101618822044, 8172.877406838902, 6728.259891411941, 6782.898256526058, 6786.423154031864, 6821.965890170517, 6852.588844669336, 6313.0, 6447.935520644921, 6450.064740612679, 6474.935250647433, 6503.544751867324, 7237.167725711611, 7332.046833911558, 7399.96300018518, 7500.8499830002, 7507.962460187664, 7533.472656913963, 7588.62056897164, 7617.27635874591, 7620.923790762243, 7699.730509432143, 5931.110333449845, 6158.04550294705, 6701.899471507833, 6745.763898263734, 6776.119104516381, 6182.443580077815, 6261.342559031236, 6297.338779428094, 6301.684915754286, 6304.085907543289, 6018.097285407224, 6219.502439804714, 6238.282597501164, 6278.309385967448, 6382.521310901794, 5990.131430942576, 6003.939960600513, 6026.728797204224, 6043.2748070231855, 6261.405166509175, 6193.194884664965, 6229.2524897010835, 6272.341404152681, 6283.151774510566, 6293.653849038164, 5656.85857853557, 5704.486596206361, 5717.256756621613, 5717.942820571741, 5733.140028995684, 5693.146028095819, 5733.684647344269, 5780.884382312414, 5896.410358964069, 5912.320083190316], "unit": "ms", "name": "mootools.html", "value": 4039.2400027998365}, {"lowerIsBetter": false, "replicates": [313.7678118192537, 317.6347200719173, 323.3097337185112, 325.6971016954233, 327.1657273951424, 5473.06957817171, 5543.336998900324, 5566.304211973504, 5583.720813959301, 5668.404817494165, 5493.23094766733, 5507.807226747064, 5540.058190107681, 5543.473370029851, 5547.55619550436, 4158.355454904479, 4236.809343579546, 4240.27915254406, 4294.828206871722, 4304.999999999992, 4229.471316085489, 4234.682398820086, 4245.320748680197, 4253.043065310296, 4253.979045029187, 4186.769727664977, 4190.455240818689, 4192.161567686459, 4195.160967806436, 4203.47456567929, 4190.685698572604, 4214.051838336396, 4243.80902859369, 4252.149570085995, 4266.360045993095, 3578.6958108560802, 3687.115092377837, 3730.7015438764834, 3731.962680373216, 3734.589195188527, 5200.947990520122, 5276.0, 5284.867878303073, 5287.23335116406, 5316.12283973144, 4825.276208568707, 4882.658213925027, 4888.266759986031, 4888.291197776338, 4888.926666099976, 5803.593748437611, 5833.270841144857, 5845.532357411439, 5854.18041474194, 5857.85355366115, 3943.9211215775813, 4020.5175378954714, 4034.132661477767, 4034.293998550271, 4035.9394609080887, 6046.3349031606485, 6105.542084343648, 6112.3276439592055, 6123.540734444934, 6140.631562106243, 4128.1330920507025, 4133.586641335843, 4136.8138433769955, 4145.730527515701, 4151.564085771011, 4199.286121359315, 4201.285781417167, 4203.096334288081, 4214.072903961123, 4217.219814334358, 4737.265723812815, 4835.782389792468, 4847.61219102478, 4855.36880205571, 4855.465898751135, 5843.18195452637, 5847.766089356463, 5847.912281315784, 5848.561357898089, 5852.882942341129, 1473.4106357456888, 1493.6415260337442, 1495.0655840099937, 1495.200067963656, 1495.364470100203, 982.7199248214367, 1004.9397036177853, 1018.6231094495084, 1023.1661196125134, 1023.4064242739194, 5056.191009438472, 5070.264811602371, 5074.923876141861, 5080.263361812516, 5080.669756465818, 6029.60807547508, 6045.214122164179, 6057.3336932937345, 6064.211652485149, 6065.6663883486835, 5043.646944713908, 5054.09026375256, 5058.772355244023, 5059.468755780664, 5063.088644044107, 3200.647928727838, 3251.024692592213, 3257.267114899129, 3274.9836250818594, 3282.5404443377947, 5625.409332020079, 5682.289713785777, 5689.9146512802345, 5691.459311365414, 5726.341470730836, 6254.21822272216, 6273.8745225095245, 6284.0, 6285.120083188357, 6291.842703932347, 5678.829635110953, 5711.485966262973, 5732.541396688255, 5733.627314224562, 5737.311522617312, 5946.1972633693895, 6047.334793172659, 6053.182820319376, 6078.483328917092, 6092.147099406176, 5936.762529498945, 5943.524518038633, 5951.523878089829, 5951.583389162717, 5977.342492325927, 5700.230468886647, 5708.828735137952, 5713.400092990176, 5718.628289161191, 5730.054541000688, 4137.524184718675, 4191.371294305878, 4195.706300558932, 4201.432806571073, 4212.326027835532, 5875.73559189846, 6016.217891674054, 6036.094585811988, 6077.058056001327, 6097.725602347817, 5788.421157884346, 5867.061270196748, 5872.1778950946045, 5881.500072493886, 5887.264091988502, 5861.120831875082, 5869.6771677558145, 5873.882522349614, 5874.500667443315, 5879.588428809942, 5613.57898157648, 5698.287714035746, 5720.799772007959, 5723.31320241557, 5737.454941780524, 5871.94128058714, 5878.500327472042, 5889.617174883619, 5895.174675545341, 5900.675462849585, 5742.454466825645, 5745.224394706661, 5752.223449834386, 5758.539316854558, 5767.452092051249], "unit": "ms", "name": "prototype.html", "value": 4368.995433046419}, {"lowerIsBetter": false, "replicates": [655.1123228026024, 730.1566690472505, 767.761993781928, 786.3984052200065, 798.3214267872307, 11344.092472602193, 11399.088072954164, 11427.0, 11495.885041149575, 11595.884041159587, 11648.534058637666, 11733.53065877364, 11736.35450050247, 11736.53053877846, 11746.295222286648, 627.6046090962687, 632.2065807411692, 802.5305196460064, 807.7980504873782, 827.8551253530638, 821.9589020548979, 822.8066404394963, 827.4166712467696, 828.0477450931447, 829.0921441022101, 864.4726716702806, 868.6655637579546, 868.9217970382664, 874.1346067393298, 874.64576846377, 857.1471385970967, 858.3862538285125, 858.6050416808275, 860.496609483453, 860.7030574451804, 629.9055141728732, 636.8789929913348, 638.7349250061219, 642.5470043619238, 643.1606753187089, 12072.637820865388, 12092.093093018058, 12176.269423834598, 12201.877981220163, 12207.145499815017, 10979.890201097967, 11526.654200374001, 11565.248258863146, 11596.246243994114, 11849.644510664608, 9208.631654733803, 9344.766380840465, 9423.151916327495, 9520.428774273565, 9522.523873806282, 3221.8389080546112, 3246.8376581170846, 3265.2979609384097, 3356.8321583920706, 3363.6972672459597, 37764.99999999972, 37799.43300850462, 37830.62169378299, 38041.80979095114, 38134.23731525382, 9141.308857861317, 9336.766580835534, 9337.439753614804, 9642.276829237835, 9721.854172187423, 16803.41188058412, 16811.0, 16818.579535511464, 16819.15904204785, 16837.57906052334, 6207.379262073847, 6219.315875253718, 6341.460975817107, 6402.679866006681, 6456.0, 3462.117160124152, 3589.120665436985, 3596.7841929483793, 3611.0, 3631.673149416565, 2492.6510288559616, 2498.675172227599, 2520.231329444537, 2527.3176242414447, 2530.430653103037, 476.49729535339856, 485.1752021563356, 502.502522502727, 503.04170555092605, 520.7344254430268, 379.4081233276043, 388.6948745234977, 471.2977663281754, 476.59965628871913, 500.9705056109657, 6854.143232095988, 7117.71529138839, 7147.499675022803, 7327.706891724378, 7430.405567554582, 452.1003203624763, 514.951079647433, 517.6764522173642, 523.3013926408212, 542.0108302348231, 3427.640097789746, 3450.3616830885862, 3457.8098204598487, 3561.3233485638166, 3609.512715783388, 49635.503644963814, 49770.75114624476, 50136.0, 50293.24560131528, 52703.73648131735, 42677.57322426736, 43658.56341436609, 43688.0, 43710.0, 43843.78078109589, 39575.208495829924, 40251.19497610031, 40410.595894041275, 44189.77905110454, 44571.77714111473, 7528.698852045857, 7563.621818909142, 7816.452848300792, 7936.603169841369, 7981.920180798118, 31029.534556982115, 31368.05895823129, 31451.0, 31538.211544711565, 31799.523007155374, 35821.0, 37519.0, 39001.804990974866, 39130.6086939127, 39337.0, 10342.586296548054, 10393.9480302598, 10460.63387781424, 10485.895141048491, 10740.83888741685, 11050.0, 11083.944580277048, 11085.612003579836, 11244.606438774603, 11311.604093856675, 9562.521873906138, 9659.517024148623, 9785.510724463891, 9871.950640246752, 10115.797684046425, 10196.694099177037, 10418.531166097695, 10494.737631558966, 10528.157747380037, 10542.10392116648, 9412.247020238228, 9467.911190213214, 9580.76048098803, 9627.807443850943, 9664.855027174739, 9353.158215760614, 9358.766030849283, 9365.953170234105, 9391.906080939103, 9414.858777118487, 8823.117688231383, 9129.406588571721, 9148.908510914805, 9193.0, 9416.0], "unit": "ms", "name": "yui.html", "value": 5629.0933112798775}], "name": "dromaeo_css", "value": 6297.78516374822}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 113.0, 113.0, 112.0, 127.0, 111.0, 115.0, 112.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 113.8}, {"lowerIsBetter": true, "replicates": [163.0, 132.0, 157.0, 163.0, 132.0, 156.0, 149.0, 131.0, 168.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 164.0, 166.0, 162.0, 165.0, 173.0, 162.0, 164.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 73.0, 74.0, 158.0, 73.0, 73.0, 73.0, 73.0, 152.0], "unit": "ms", "name": "audio-fft", "value": 89.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 94.0, 95.0, 96.0, 135.0, 96.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 146.0, 149.0, 147.0, 147.0, 148.0, 148.0, 151.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [74.0, 78.0, 75.0, 74.0, 76.0, 76.0, 78.0, 80.0, 72.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 75.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 69.0, 68.0, 69.0, 67.0, 67.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 83.0, 86.0, 84.0, 94.0, 85.0, 85.0, 94.0, 100.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.6}, {"lowerIsBetter": true, "replicates": [119.0, 125.0, 134.0, 123.0, 135.0, 128.0, 122.0, 127.0, 127.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.7}, {"lowerIsBetter": true, "replicates": [136.0, 148.0, 148.0, 145.0, 158.0, 135.0, 147.0, 149.0, 152.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 72.0, 71.0, 73.0, 69.0, 69.0, 72.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1549.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "Richards", "value": 211.17656399999993}, {"lowerIsBetter": false, "replicates": [184.84288354898337], "unit": "score", "name": "DeltaBlue", "value": 357.6983799999999}, {"lowerIsBetter": false, "replicates": [277.623542476402], "unit": "score", "name": "Encrypt", "value": 958.7839620000002}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1044.932079414838], "unit": "score", "name": "RayTrace", "value": 708.1694730000004}, {"lowerIsBetter": false, "replicates": [744.6016381236038], "unit": "score", "name": "Earley", "value": 895.0598090000003}, {"lowerIsBetter": false, "replicates": [11988.095238095239], "unit": "score", "name": "Boyer", "value": 55.59373584905661}, {"lowerIsBetter": false, "replicates": [27054.054054054053], "unit": "score", "name": "RegExp", "value": 33.67277222777225}, {"lowerIsBetter": false, "replicates": [596.6587112171837], "unit": "score", "name": "Splay", "value": 136.578916}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21308.77796748409}]} 02:07:46 INFO - RETURN: dromaeo_css: 6297.79 02:07:46 INFO - RETURN: kraken: 1549.80 02:07:46 INFO - RETURN: v8_7: 21308.78 02:07:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21308.78"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1549.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6297.79"}}} 02:07:46 INFO - Return code: 0 02:07:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:07:46 INFO - # TBPL SUCCESS # 02:07:46 INFO - Running post-action listener: _resource_record_post_action 02:07:46 INFO - Running post-run listener: _resource_record_post_run 02:07:47 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521834496; Read time: 20; Write time: 508004 02:07:47 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 248954880; Read time: 0; Write time: 345492 02:07:47 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272879616; Read time: 20; Write time: 162512 02:07:47 INFO - Running post-run listener: _upload_blobber_files 02:07:47 INFO - Blob upload gear active. 02:07:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:07:47 INFO - Copying logs to upload dir... 02:07:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.962220 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-11 02:07:47.349215) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 02:07:47.352772) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009930 build_url: 'https://queue.taskcluster.net/v1/task/_uAz4KFUTSaBXVlJ6kblpA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 02:07:47.403452) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 02:07:47.403774) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1449826554.484300-1284488378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 02:07:47.453643) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 02:07:47.453957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 02:07:47.454336) ========= ========= Total master_lag: 0.25 =========