builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1459944872.79 results: success (0) buildid: 20160406042913 builduid: 83da77abec684c899071bb08e44764dc revision: d37f13e88aae4ba2c69951189f3d88c723bfc9a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:32.790513) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:32.790885) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:32.791167) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006371 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:32.818151) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:32.818444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:32.896567) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:32.896842) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004646 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:32.934527) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:32.934817) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:32.935140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:32.935432) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-06 05:14:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-06 05:14:35 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142119 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:33.090349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:33.090653) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020603 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:33.143783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:33.144090) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d37f13e88aae4ba2c69951189f3d88c723bfc9a7 --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 d37f13e88aae4ba2c69951189f3d88c723bfc9a7 --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=e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-06 05:14:35,811 truncating revision to first 12 chars 2016-04-06 05:14:35,812 Setting DEBUG logging. 2016-04-06 05:14:35,812 attempt 1/10 2016-04-06 05:14:35,812 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d37f13e88aae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 05:14:36,077 unpacking tar archive at: fx-team-d37f13e88aae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567365 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:33.727681) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:33.728004) ========= echo d37f13e88aae4ba2c69951189f3d88c723bfc9a7 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd37f13e88aae4ba2c69951189f3d88c723bfc9a7'] 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=e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d37f13e88aae4ba2c69951189f3d88c723bfc9a7 program finished with exit code 0 elapsedTime=0.003748 script_repo_revision: 'd37f13e88aae4ba2c69951189f3d88c723bfc9a7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:33.778773) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:33.779054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 05:14:33.790454) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-06 05:14:33.790727) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--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=e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:14:36 INFO - MultiFileLogger online at 20160406 05:14:36 in /builds/slave/test 05:14:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:14:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:14:36 INFO - {'append_to_log': False, 05:14:36 INFO - 'base_work_dir': '/builds/slave/test', 05:14:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:14:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:14:36 INFO - 'branch': 'Fx-Team-Non-PGO', 05:14:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:14:36 INFO - 'config_files': ('talos/linux_config.py',), 05:14:36 INFO - 'default_actions': ('clobber', 05:14:36 INFO - 'read-buildbot-config', 05:14:36 INFO - 'download-and-extract', 05:14:36 INFO - 'populate-webroot', 05:14:36 INFO - 'create-virtualenv', 05:14:36 INFO - 'install', 05:14:36 INFO - 'run-tests'), 05:14:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:14:36 INFO - 'download_minidump_stackwalk': True, 05:14:36 INFO - 'download_symbols': 'ondemand', 05:14:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:14:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:14:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:14:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:14:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:14:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:14:36 INFO - 'installer_path': 'installer.exe', 05:14:36 INFO - 'log_level': 'info', 05:14:36 INFO - 'log_name': 'talos', 05:14:36 INFO - 'log_to_console': True, 05:14:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:14:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:14:36 INFO - 'opt_config_files': (), 05:14:36 INFO - 'pip_index': False, 05:14:36 INFO - 'sps_profile': False, 05:14:36 INFO - 'sps_profile_interval': 0, 05:14:36 INFO - 'suite': 'dromaeojs', 05:14:36 INFO - 'system_bits': '32', 05:14:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:14:36 INFO - 'title': 'talos-linux64-ix-067', 05:14:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:14:36 INFO - 'use_talos_json': True, 05:14:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:14:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:14:36 INFO - 'work_dir': 'build'} 05:14:36 INFO - ##### 05:14:36 INFO - ##### Running clobber step. 05:14:36 INFO - ##### 05:14:36 INFO - Running pre-action listener: _resource_record_pre_action 05:14:36 INFO - Running main action method: clobber 05:14:36 INFO - rmtree: /builds/slave/test/build 05:14:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:14:37 INFO - Running post-action listener: _resource_record_post_action 05:14:37 INFO - ##### 05:14:37 INFO - ##### Running read-buildbot-config step. 05:14:37 INFO - ##### 05:14:37 INFO - Running pre-action listener: _resource_record_pre_action 05:14:37 INFO - Running main action method: read_buildbot_config 05:14:37 INFO - Using buildbot properties: 05:14:37 INFO - { 05:14:37 INFO - "project": "", 05:14:37 INFO - "product": "firefox", 05:14:37 INFO - "script_repo_revision": "production", 05:14:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:14:37 INFO - "repository": "", 05:14:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:14:37 INFO - "buildid": "20160406042913", 05:14:37 INFO - "pgo_build": "False", 05:14:37 INFO - "basedir": "/builds/slave/test", 05:14:37 INFO - "buildnumber": 1538, 05:14:37 INFO - "slavename": "talos-linux64-ix-067", 05:14:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:14:37 INFO - "platform": "ubuntu64_hw", 05:14:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:14:37 INFO - "branch": "fx-team", 05:14:37 INFO - "repo_path": "integration/fx-team", 05:14:37 INFO - "revision": "d37f13e88aae4ba2c69951189f3d88c723bfc9a7", 05:14:37 INFO - "stage_platform": "linux64", 05:14:37 INFO - "builduid": "83da77abec684c899071bb08e44764dc", 05:14:37 INFO - "slavebuilddir": "test" 05:14:37 INFO - } 05:14:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:14:37 INFO - Running post-action listener: _resource_record_post_action 05:14:37 INFO - ##### 05:14:37 INFO - ##### Running download-and-extract step. 05:14:37 INFO - ##### 05:14:37 INFO - Running pre-action listener: _resource_record_pre_action 05:14:37 INFO - Running main action method: download_and_extract 05:14:37 INFO - mkdir: /builds/slave/test/build/tests 05:14:37 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')]} 05:14:37 INFO - https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:14:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:14:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:14:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:14:39 INFO - Downloaded 1361 bytes. 05:14:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:14:39 INFO - Using the following test package requirements: 05:14:39 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:14:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:14:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:14:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:39 INFO - u'jsshell-linux-x86_64.zip'], 05:14:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:14:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:14:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:14:39 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:14:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:14:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:14:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:14: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')]} 05:14:39 INFO - https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:14:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:14:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:14:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:41 INFO - Downloaded 22129793 bytes. 05:14:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:14:43 INFO - Return code: 0 05:14:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:14: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')]} 05:14:43 INFO - https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:44 INFO - Downloaded 22129793 bytes. 05:14:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:14:46 INFO - Return code: 0 05:14: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')]} 05:14:46 INFO - https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:14:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:14:47 INFO - Downloaded 10847617 bytes. 05:14:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:14:48 INFO - Return code: 0 05:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:48 INFO - https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:14:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:14:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:14:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:14:50 INFO - Downloaded 54184538 bytes. 05:14:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:14:50 INFO - mkdir: /builds/slave/test/properties 05:14:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:14:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:14:50 INFO - Contents: 05:14:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:14:51 INFO - Running post-action listener: _resource_record_post_action 05:14:51 INFO - Running post-action listener: set_extra_try_arguments 05:14:51 INFO - ##### 05:14:51 INFO - ##### Running populate-webroot step. 05:14:51 INFO - ##### 05:14:51 INFO - Running pre-action listener: _resource_record_pre_action 05:14:51 INFO - Running main action method: populate_webroot 05:14:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:14:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:14:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:14:51 INFO - '--tppagecycles', 05:14:51 INFO - '7'], 05:14:51 INFO - 'tests': ['tsvgm']}}, 05:14:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:14:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:14:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:14:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:14:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:14:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:14:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:51 INFO - 'talos_options': ['--disable-e10s'], 05:14:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:51 INFO - 'talos_options': ['--disable-e10s'], 05:14:51 INFO - 'tests': ['damp', 'tps']}, 05:14:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:51 INFO - 'tests': ['damp', 'tps']}, 05:14:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:14:51 INFO - 'tests': ['dromaeo_dom']}, 05:14:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:14:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:14:51 INFO - 'tests': ['a11yr', 05:14:51 INFO - 'ts_paint', 05:14:51 INFO - 'tpaint', 05:14:51 INFO - 'sessionrestore', 05:14:51 INFO - 'sessionrestore_no_auto_restore', 05:14:51 INFO - 'tabpaint']}, 05:14:51 INFO - 'other-e10s': {'tests': ['a11yr', 05:14:51 INFO - 'ts_paint', 05:14:51 INFO - 'tpaint', 05:14:51 INFO - 'sessionrestore', 05:14:51 INFO - 'sessionrestore_no_auto_restore', 05:14:51 INFO - 'tabpaint']}, 05:14:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:14:51 INFO - 'ts_paint', 05:14:51 INFO - 'tpaint', 05:14:51 INFO - 'sessionrestore', 05:14:51 INFO - 'sessionrestore_no_auto_restore', 05:14:51 INFO - 'tabpaint']}, 05:14:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:14:51 INFO - 'ts_paint', 05:14:51 INFO - 'tpaint', 05:14:51 INFO - 'sessionrestore', 05:14:51 INFO - 'sessionrestore_no_auto_restore', 05:14:51 INFO - 'tabpaint']}, 05:14:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:14:51 INFO - 'tests': ['a11yr', 05:14:51 INFO - 'ts_paint', 05:14:51 INFO - 'tpaint', 05:14:51 INFO - 'sessionrestore', 05:14:51 INFO - 'sessionrestore_no_auto_restore', 05:14:51 INFO - 'tabpaint']}, 05:14:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:14:51 INFO - 'tests': ['a11yr', 05:14:51 INFO - 'ts_paint', 05:14:51 INFO - 'tpaint', 05:14:51 INFO - 'sessionrestore', 05:14:51 INFO - 'sessionrestore_no_auto_restore', 05:14:51 INFO - 'tabpaint']}, 05:14:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:14:51 INFO - 'tests': ['tsvgx', 05:14:51 INFO - 'tsvgr_opacity', 05:14:51 INFO - 'tart', 05:14:51 INFO - 'tscrollx', 05:14:51 INFO - 'cart']}, 05:14:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:14:51 INFO - 'tsvgr_opacity', 05:14:51 INFO - 'tart', 05:14:51 INFO - 'tscrollx', 05:14:51 INFO - 'cart']}, 05:14:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:51 INFO - 'talos_options': ['--disable-e10s'], 05:14:51 INFO - 'tests': ['tp5o']}, 05:14:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:51 INFO - 'tests': ['tp5o']}, 05:14:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:51 INFO - 'talos_options': ['--disable-e10s', 05:14:51 INFO - '--xperf_path', 05:14:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:51 INFO - 'tests': ['tp5n']}, 05:14:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:51 INFO - 'talos_options': ['--xperf_path', 05:14:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:51 INFO - 'tests': ['tp5n']}}, 05:14:51 INFO - 'talos.zip': {'path': '', 05:14:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:14:51 INFO - Running post-action listener: _resource_record_post_action 05:14:51 INFO - ##### 05:14:51 INFO - ##### Running create-virtualenv step. 05:14:51 INFO - ##### 05:14:51 INFO - Running pre-action listener: _resource_record_pre_action 05:14:51 INFO - Running main action method: create_virtualenv 05:14:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:14:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:14:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:14:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:14:51 INFO - Using real prefix '/usr' 05:14:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:14:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:14:53 INFO - Installing pip.................done. 05:14:53 INFO - Return code: 0 05:14:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:14:53 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')]} 05:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:53 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')]} 05:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f22370a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f640>, '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 0x1250540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12509d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', '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 05:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:14:53 INFO - Using env: {'DISPLAY': ':0', 05:14:53 INFO - 'HOME': '/home/cltbld', 05:14:53 INFO - 'LANG': 'en_US.UTF-8', 05:14:53 INFO - 'LANGUAGE': 'en_US:en', 05:14:53 INFO - 'LOGNAME': 'cltbld', 05:14:53 INFO - 'MAIL': '/var/mail/cltbld', 05:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:53 INFO - 'MOZ_NO_REMOTE': '1', 05:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:53 INFO - 'NO_EM_RESTART': '1', 05:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:53 INFO - 'PWD': '/builds/slave/test', 05:14:53 INFO - 'SHELL': '/bin/bash', 05:14:53 INFO - 'SHLVL': '1', 05:14:53 INFO - 'TERM': 'linux', 05:14:53 INFO - 'TMOUT': '86400', 05:14:53 INFO - 'USER': 'cltbld', 05:14:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', 05:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:53 INFO - '_': '/tools/buildbot/bin/python'} 05:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:53 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 05:14:53 INFO - Cleaning up... 05:14:53 INFO - Return code: 0 05:14:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:14:53 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')]} 05:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:53 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')]} 05:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f22370a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f640>, '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 0x1250540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12509d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', '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 05:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:14:53 INFO - Using env: {'DISPLAY': ':0', 05:14:53 INFO - 'HOME': '/home/cltbld', 05:14:53 INFO - 'LANG': 'en_US.UTF-8', 05:14:53 INFO - 'LANGUAGE': 'en_US:en', 05:14:53 INFO - 'LOGNAME': 'cltbld', 05:14:53 INFO - 'MAIL': '/var/mail/cltbld', 05:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:53 INFO - 'MOZ_NO_REMOTE': '1', 05:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:53 INFO - 'NO_EM_RESTART': '1', 05:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:53 INFO - 'PWD': '/builds/slave/test', 05:14:53 INFO - 'SHELL': '/bin/bash', 05:14:53 INFO - 'SHLVL': '1', 05:14:53 INFO - 'TERM': 'linux', 05:14:53 INFO - 'TMOUT': '86400', 05:14:53 INFO - 'USER': 'cltbld', 05:14:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', 05:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:53 INFO - '_': '/tools/buildbot/bin/python'} 05:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:54 INFO - Downloading/unpacking psutil>=0.7.1 05:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:56 INFO - Installing collected packages: psutil 05:14:56 INFO - Running setup.py install for psutil 05:14:56 INFO - building 'psutil._psutil_linux' extension 05:14:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:14:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:14:56 INFO - building 'psutil._psutil_posix' extension 05:14:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:14:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:56 INFO - Successfully installed psutil 05:14:56 INFO - Cleaning up... 05:14:57 INFO - Return code: 0 05:14:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:14: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')]} 05:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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')]} 05:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f22370a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f640>, '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 0x1250540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12509d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', '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 05:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:14:57 INFO - Using env: {'DISPLAY': ':0', 05:14:57 INFO - 'HOME': '/home/cltbld', 05:14:57 INFO - 'LANG': 'en_US.UTF-8', 05:14:57 INFO - 'LANGUAGE': 'en_US:en', 05:14:57 INFO - 'LOGNAME': 'cltbld', 05:14:57 INFO - 'MAIL': '/var/mail/cltbld', 05:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:57 INFO - 'MOZ_NO_REMOTE': '1', 05:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:57 INFO - 'NO_EM_RESTART': '1', 05:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:57 INFO - 'PWD': '/builds/slave/test', 05:14:57 INFO - 'SHELL': '/bin/bash', 05:14:57 INFO - 'SHLVL': '1', 05:14:57 INFO - 'TERM': 'linux', 05:14:57 INFO - 'TMOUT': '86400', 05:14:57 INFO - 'USER': 'cltbld', 05:14:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', 05:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:57 INFO - '_': '/tools/buildbot/bin/python'} 05:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:14:59 INFO - Installing collected packages: mozsystemmonitor 05:14:59 INFO - Running setup.py install for mozsystemmonitor 05:14:59 INFO - Successfully installed mozsystemmonitor 05:14:59 INFO - Cleaning up... 05:14:59 INFO - Return code: 0 05:14:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f22370a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f640>, '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 0x1250540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12509d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', '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 05:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:14:59 INFO - Using env: {'DISPLAY': ':0', 05:14:59 INFO - 'HOME': '/home/cltbld', 05:14:59 INFO - 'LANG': 'en_US.UTF-8', 05:14:59 INFO - 'LANGUAGE': 'en_US:en', 05:14:59 INFO - 'LOGNAME': 'cltbld', 05:14:59 INFO - 'MAIL': '/var/mail/cltbld', 05:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:59 INFO - 'MOZ_NO_REMOTE': '1', 05:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:59 INFO - 'NO_EM_RESTART': '1', 05:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:59 INFO - 'PWD': '/builds/slave/test', 05:14:59 INFO - 'SHELL': '/bin/bash', 05:14:59 INFO - 'SHLVL': '1', 05:14:59 INFO - 'TERM': 'linux', 05:14:59 INFO - 'TMOUT': '86400', 05:14:59 INFO - 'USER': 'cltbld', 05:14:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', 05:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:59 INFO - '_': '/tools/buildbot/bin/python'} 05:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:15:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:15:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:02 INFO - Downloading docopt-0.6.1.tar.gz 05:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:02 INFO - Running setup.py install for blobuploader 05:15:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:15:02 INFO - Running setup.py install for requests 05:15:02 INFO - Running setup.py install for docopt 05:15:02 INFO - Successfully installed blobuploader requests docopt 05:15:02 INFO - Cleaning up... 05:15:03 INFO - Return code: 0 05:15:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f22370a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f640>, '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 0x1250540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12509d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', '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 05:15:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 05:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 05:15:03 INFO - Using env: {'DISPLAY': ':0', 05:15:03 INFO - 'HOME': '/home/cltbld', 05:15:03 INFO - 'LANG': 'en_US.UTF-8', 05:15:03 INFO - 'LANGUAGE': 'en_US:en', 05:15:03 INFO - 'LOGNAME': 'cltbld', 05:15:03 INFO - 'MAIL': '/var/mail/cltbld', 05:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:03 INFO - 'MOZ_NO_REMOTE': '1', 05:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:03 INFO - 'NO_EM_RESTART': '1', 05:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:03 INFO - 'PWD': '/builds/slave/test', 05:15:03 INFO - 'SHELL': '/bin/bash', 05:15:03 INFO - 'SHLVL': '1', 05:15:03 INFO - 'TERM': 'linux', 05:15:03 INFO - 'TMOUT': '86400', 05:15:03 INFO - 'USER': 'cltbld', 05:15:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', 05:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:03 INFO - '_': '/tools/buildbot/bin/python'} 05:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:03 INFO - Running setup.py (path:/tmp/pip-0Vcnz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:03 INFO - Running setup.py (path:/tmp/pip-0Q5lG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:03 INFO - Running setup.py (path:/tmp/pip-sjivyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:03 INFO - Running setup.py (path:/tmp/pip-p_j7CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:03 INFO - Running setup.py (path:/tmp/pip-LkE4H1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:03 INFO - Running setup.py (path:/tmp/pip-lNTQrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:03 INFO - Running setup.py (path:/tmp/pip-31FUXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:03 INFO - Running setup.py (path:/tmp/pip-c6K4BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:03 INFO - Running setup.py (path:/tmp/pip-SRzxo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:03 INFO - Running setup.py (path:/tmp/pip-GIHkGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:03 INFO - Running setup.py (path:/tmp/pip-H5UkEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:04 INFO - Running setup.py (path:/tmp/pip-gpkDZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:04 INFO - Running setup.py (path:/tmp/pip-T2FF1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:04 INFO - Running setup.py (path:/tmp/pip-lhXTi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:04 INFO - Running setup.py (path:/tmp/pip-vT2HUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:04 INFO - Running setup.py (path:/tmp/pip-Evv153-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:04 INFO - Running setup.py (path:/tmp/pip-oGWqJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:15:04 INFO - Running setup.py install for manifestparser 05:15:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:15:04 INFO - Running setup.py install for mozcrash 05:15:04 INFO - Running setup.py install for mozdebug 05:15:04 INFO - Running setup.py install for mozdevice 05:15:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:15:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:15:04 INFO - Running setup.py install for mozfile 05:15:04 INFO - Running setup.py install for mozhttpd 05:15:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Running setup.py install for mozinfo 05:15:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Running setup.py install for mozInstall 05:15:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Running setup.py install for mozleak 05:15:05 INFO - Running setup.py install for mozlog 05:15:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Running setup.py install for moznetwork 05:15:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Running setup.py install for mozprocess 05:15:05 INFO - Running setup.py install for mozprofile 05:15:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Running setup.py install for mozrunner 05:15:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:05 INFO - Running setup.py install for mozscreenshot 05:15:06 INFO - Running setup.py install for moztest 05:15:06 INFO - Running setup.py install for mozversion 05:15:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:06 INFO - Cleaning up... 05:15:06 INFO - Return code: 0 05:15:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f22370a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f640>, '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 0x1250540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12509d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', '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 05:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:15:06 INFO - Using env: {'DISPLAY': ':0', 05:15:06 INFO - 'HOME': '/home/cltbld', 05:15:06 INFO - 'LANG': 'en_US.UTF-8', 05:15:06 INFO - 'LANGUAGE': 'en_US:en', 05:15:06 INFO - 'LOGNAME': 'cltbld', 05:15:06 INFO - 'MAIL': '/var/mail/cltbld', 05:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:06 INFO - 'MOZ_NO_REMOTE': '1', 05:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:06 INFO - 'NO_EM_RESTART': '1', 05:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:06 INFO - 'PWD': '/builds/slave/test', 05:15:06 INFO - 'SHELL': '/bin/bash', 05:15:06 INFO - 'SHLVL': '1', 05:15:06 INFO - 'TERM': 'linux', 05:15:06 INFO - 'TMOUT': '86400', 05:15:06 INFO - 'USER': 'cltbld', 05:15:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', 05:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:06 INFO - '_': '/tools/buildbot/bin/python'} 05:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:06 INFO - Running setup.py (path:/tmp/pip-SqqK_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:06 INFO - Running setup.py (path:/tmp/pip-_z2Hab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:06 INFO - Running setup.py (path:/tmp/pip-nw1PSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:06 INFO - Running setup.py (path:/tmp/pip-aD2GCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:06 INFO - Running setup.py (path:/tmp/pip-LCKh0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:06 INFO - Running setup.py (path:/tmp/pip-300S2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:06 INFO - Running setup.py (path:/tmp/pip-yM9v6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:06 INFO - Running setup.py (path:/tmp/pip-HeZs_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:07 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)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:07 INFO - Running setup.py (path:/tmp/pip-pn_ND8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:07 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)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:07 INFO - Running setup.py (path:/tmp/pip-0Fekxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:07 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)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:07 INFO - Running setup.py (path:/tmp/pip-RN3v4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:07 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)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:07 INFO - Running setup.py (path:/tmp/pip-Nf_Zc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:07 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)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:07 INFO - Running setup.py (path:/tmp/pip-Unv47h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:07 INFO - Running setup.py (path:/tmp/pip-xLsbii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:07 INFO - Running setup.py (path:/tmp/pip-JU1QbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:07 INFO - Running setup.py (path:/tmp/pip-qixHTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:07 INFO - Running setup.py (path:/tmp/pip-Aa3VfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15: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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:09 INFO - Downloading blessings-1.6.tar.gz 05:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:09 INFO - Installing collected packages: blessings 05:15:09 INFO - Running setup.py install for blessings 05:15:10 INFO - Successfully installed blessings 05:15:10 INFO - Cleaning up... 05:15:10 INFO - Return code: 0 05:15:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:10 INFO - Reading from file tmpfile_stdout 05:15:10 INFO - Current package versions: 05:15:10 INFO - argparse == 1.2.1 05:15:10 INFO - blessings == 1.6 05:15:10 INFO - blobuploader == 1.2.4 05:15:10 INFO - docopt == 0.6.1 05:15:10 INFO - manifestparser == 1.1 05:15:10 INFO - mozInstall == 1.12 05:15:10 INFO - mozcrash == 0.17 05:15:10 INFO - mozdebug == 0.1 05:15:10 INFO - mozdevice == 0.48 05:15:10 INFO - mozfile == 1.2 05:15:10 INFO - mozhttpd == 0.7 05:15:10 INFO - mozinfo == 0.9 05:15:10 INFO - mozleak == 0.1 05:15:10 INFO - mozlog == 3.1 05:15:10 INFO - moznetwork == 0.27 05:15:10 INFO - mozprocess == 0.22 05:15:10 INFO - mozprofile == 0.28 05:15:10 INFO - mozrunner == 6.11 05:15:10 INFO - mozscreenshot == 0.1 05:15:10 INFO - mozsystemmonitor == 0.0 05:15:10 INFO - moztest == 0.7 05:15:10 INFO - mozversion == 1.4 05:15:10 INFO - psutil == 3.1.1 05:15:10 INFO - requests == 1.2.3 05:15:10 INFO - wsgiref == 0.1.2 05:15:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:10 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')]} 05:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:10 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')]} 05:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f22370a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f640>, '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 0x1250540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12509d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', '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 05:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:15:10 INFO - Using env: {'DISPLAY': ':0', 05:15:10 INFO - 'HOME': '/home/cltbld', 05:15:10 INFO - 'LANG': 'en_US.UTF-8', 05:15:10 INFO - 'LANGUAGE': 'en_US:en', 05:15:10 INFO - 'LOGNAME': 'cltbld', 05:15:10 INFO - 'MAIL': '/var/mail/cltbld', 05:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:10 INFO - 'MOZ_NO_REMOTE': '1', 05:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:10 INFO - 'NO_EM_RESTART': '1', 05:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:10 INFO - 'PWD': '/builds/slave/test', 05:15:10 INFO - 'SHELL': '/bin/bash', 05:15:10 INFO - 'SHLVL': '1', 05:15:10 INFO - 'TERM': 'linux', 05:15:10 INFO - 'TMOUT': '86400', 05:15:10 INFO - 'USER': 'cltbld', 05:15:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', 05:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:10 INFO - '_': '/tools/buildbot/bin/python'} 05:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:15:10 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 2)) 05:15:10 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 3)) 05:15:10 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 4)) 05:15:10 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 5)) 05:15:10 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 6)) 05:15:10 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 7)) 05:15:10 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 8)) 05:15:10 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 9)) 05:15:10 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:15:10 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 4)) 05:15:10 INFO - Cleaning up... 05:15:10 INFO - Return code: 0 05:15:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:15:10 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')]} 05:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:10 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')]} 05:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f22370a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f640>, '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 0x1250540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12509d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', '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 05:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:15:10 INFO - Using env: {'DISPLAY': ':0', 05:15:10 INFO - 'HOME': '/home/cltbld', 05:15:10 INFO - 'LANG': 'en_US.UTF-8', 05:15:10 INFO - 'LANGUAGE': 'en_US:en', 05:15:10 INFO - 'LOGNAME': 'cltbld', 05:15:10 INFO - 'MAIL': '/var/mail/cltbld', 05:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:10 INFO - 'MOZ_NO_REMOTE': '1', 05:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:10 INFO - 'NO_EM_RESTART': '1', 05:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:10 INFO - 'PWD': '/builds/slave/test', 05:15:10 INFO - 'SHELL': '/bin/bash', 05:15:10 INFO - 'SHLVL': '1', 05:15:10 INFO - 'TERM': 'linux', 05:15:10 INFO - 'TMOUT': '86400', 05:15:10 INFO - 'USER': 'cltbld', 05:15:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', 05:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:10 INFO - '_': '/tools/buildbot/bin/python'} 05:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:10 INFO - Downloading/unpacking jsonschema 05:15:10 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 05:15:10 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 05:15:10 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 05:15:10 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 05:15:10 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 05:15:10 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 05:15:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:15:12 INFO - Downloading/unpacking functools32 (from jsonschema) 05:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:12 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:12 INFO - warning: no files found matching '*.txt' 05:15:12 INFO - no previously-included directories found matching 'build' 05:15:12 INFO - no previously-included directories found matching 'dist' 05:15:12 INFO - no previously-included directories found matching '.git*' 05:15:12 INFO - Installing collected packages: jsonschema, functools32 05:15:12 INFO - Running setup.py install for functools32 05:15:13 INFO - warning: no files found matching '*.txt' 05:15:13 INFO - no previously-included directories found matching 'build' 05:15:13 INFO - no previously-included directories found matching 'dist' 05:15:13 INFO - no previously-included directories found matching '.git*' 05:15:13 INFO - Successfully installed jsonschema functools32 05:15:13 INFO - Cleaning up... 05:15:13 INFO - Return code: 0 05:15:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f22370a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f640>, '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 0x1250540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12509d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', '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 05:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:15:13 INFO - Using env: {'DISPLAY': ':0', 05:15:13 INFO - 'HOME': '/home/cltbld', 05:15:13 INFO - 'LANG': 'en_US.UTF-8', 05:15:13 INFO - 'LANGUAGE': 'en_US:en', 05:15:13 INFO - 'LOGNAME': 'cltbld', 05:15:13 INFO - 'MAIL': '/var/mail/cltbld', 05:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:13 INFO - 'MOZ_NO_REMOTE': '1', 05:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:13 INFO - 'NO_EM_RESTART': '1', 05:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:13 INFO - 'PWD': '/builds/slave/test', 05:15:13 INFO - 'SHELL': '/bin/bash', 05:15:13 INFO - 'SHLVL': '1', 05:15:13 INFO - 'TERM': 'linux', 05:15:13 INFO - 'TMOUT': '86400', 05:15:13 INFO - 'USER': 'cltbld', 05:15:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', 05:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:13 INFO - '_': '/tools/buildbot/bin/python'} 05:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:13 INFO - Downloading/unpacking flake8 05:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:15:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:15:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:15:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:16 INFO - no previously-included directories found matching 'docs/_build' 05:15:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:15:16 INFO - Running setup.py install for pep8 05:15:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:16 INFO - no previously-included directories found matching 'docs/_build' 05:15:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:15:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:15:16 INFO - Cleaning up... 05:15:16 INFO - Return code: 0 05:15:16 INFO - Running post-action listener: _resource_record_post_action 05:15:16 INFO - Running post-action listener: _start_resource_monitoring 05:15:16 INFO - Starting resource monitoring. 05:15:16 INFO - ##### 05:15:16 INFO - ##### Running install step. 05:15:16 INFO - ##### 05:15:16 INFO - Running pre-action listener: _resource_record_pre_action 05:15:16 INFO - Running main action method: install 05:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:17 INFO - Reading from file tmpfile_stdout 05:15:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:17 INFO - Reading from file tmpfile_stdout 05:15:17 INFO - Output received: 05:15:17 INFO - Usage: mozinstall [options] installer 05:15:17 INFO - Options: 05:15:17 INFO - -h, --help show this help message and exit 05:15:17 INFO - -d DEST, --destination=DEST 05:15:17 INFO - Directory to install application into. [default: 05:15:17 INFO - "/builds/slave/test"] 05:15:17 INFO - --app=APP Application being installed. [default: firefox] 05:15:17 INFO - mkdir: /builds/slave/test/build/application 05:15:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:15:32 INFO - Reading from file tmpfile_stdout 05:15:32 INFO - Output received: 05:15:32 INFO - /builds/slave/test/build/application/firefox/firefox 05:15:32 INFO - Running post-action listener: _resource_record_post_action 05:15:32 INFO - ##### 05:15:32 INFO - ##### Running run-tests step. 05:15:32 INFO - ##### 05:15:32 INFO - Running pre-action listener: _resource_record_pre_action 05:15:32 INFO - Running main action method: run_tests 05:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:32 INFO - Python 2.7.3 05:15:32 INFO - Return code: 0 05:15:32 INFO - grabbing minidump binary from tooltool 05:15:32 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')]} 05:15:32 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 0x124f640>, '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 0x1250540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12509d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:32 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 05:15:32 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 05:15:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:32 INFO - Return code: 0 05:15:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:15:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:15:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:15:33 INFO - Return code: 0 05:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:15:33 INFO - Using env: {'DISPLAY': ':0', 05:15:33 INFO - 'HOME': '/home/cltbld', 05:15:33 INFO - 'LANG': 'en_US.UTF-8', 05:15:33 INFO - 'LANGUAGE': 'en_US:en', 05:15:33 INFO - 'LOGNAME': 'cltbld', 05:15:33 INFO - 'MAIL': '/var/mail/cltbld', 05:15:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:33 INFO - 'MOZ_NO_REMOTE': '1', 05:15:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:33 INFO - 'NO_EM_RESTART': '1', 05:15:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:33 INFO - 'PWD': '/builds/slave/test', 05:15:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:33 INFO - 'SHELL': '/bin/bash', 05:15:33 INFO - 'SHLVL': '1', 05:15:33 INFO - 'TERM': 'linux', 05:15:33 INFO - 'TMOUT': '86400', 05:15:33 INFO - 'USER': 'cltbld', 05:15:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945', 05:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:33 INFO - '_': '/tools/buildbot/bin/python'} 05:15:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:15:34 INFO - mozversion application_buildid: 20160406042913 05:15:34 INFO - mozversion application_changeset: d37f13e88aae4ba2c69951189f3d88c723bfc9a7 05:15:34 INFO - mozversion application_display_name: Nightly 05:15:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:34 INFO - mozversion application_name: Firefox 05:15:34 INFO - mozversion application_remotingname: firefox 05:15:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:15:34 INFO - mozversion application_vendor: Mozilla 05:15:34 INFO - mozversion application_version: 48.0a1 05:15:34 INFO - mozversion platform_buildid: 20160406042913 05:15:34 INFO - mozversion platform_changeset: d37f13e88aae4ba2c69951189f3d88c723bfc9a7 05:15:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:15:34 INFO - mozversion platform_version: 48.0a1 05:15:34 INFO - using testdate: 1459944934 05:15:34 INFO - actual date: 1459944934 05:15:34 INFO - starting webserver on 'localhost:59383' 05:15:34 INFO - SUITE-START | Running 2 tests 05:15:34 INFO - TEST-START | dromaeo_css 05:15:34 INFO - operating with platform_type : linux_ 05:15:34 INFO - Initialising browser for dromaeo_css test... 05:15:34 INFO - TEST-INFO | started process 6310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoQNLUG/profile http://localhost:59383/getInfo.html) 05:15:37 INFO - PROCESS | 6310 | __metrics Screen width/height:1600/1200 05:15:37 INFO - PROCESS | 6310 | colorDepth:24 05:15:37 INFO - PROCESS | 6310 | Browser inner width/height: 1024/697 05:15:37 INFO - PROCESS | 6310 | __metrics 05:15:38 ERROR - PROCESS | 6310 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:15:39 INFO - TEST-INFO | 6310: exit 0 05:15:39 INFO - Browser initialized. 05:15:39 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:39 INFO - TEST-INFO | started process 6390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoQNLUG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:51 INFO - PROCESS | 6390 | RSS: Main: 154529792 05:15:51 INFO - PROCESS | 6390 | 05:16:42 INFO - PROCESS | 6390 | 1459945002453 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] 05:18:53 INFO - PROCESS | 6390 | Cycle 1(1): loaded http://localhost:59383/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59383/tests/dromaeo/cssquery-ext.html) 05:18:54 INFO - PROCESS | 6390 | RSS: Main: 230735872 05:18:54 INFO - PROCESS | 6390 | 05:21:56 INFO - PROCESS | 6390 | Cycle 1(1): loaded http://localhost:59383/tests/dromaeo/cssquery-ext.html (next: http://localhost:59383/tests/dromaeo/cssquery-jquery.html) 05:21:57 INFO - PROCESS | 6390 | RSS: Main: 241311744 05:21:57 INFO - PROCESS | 6390 | 05:24:59 INFO - PROCESS | 6390 | Cycle 1(1): loaded http://localhost:59383/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59383/tests/dromaeo/cssquery-mootools.html) 05:24:59 INFO - PROCESS | 6390 | RSS: Main: 231247872 05:24:59 INFO - PROCESS | 6390 | 05:28:01 INFO - PROCESS | 6390 | Cycle 1(1): loaded http://localhost:59383/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59383/tests/dromaeo/cssquery-prototype.html) 05:28:02 INFO - PROCESS | 6390 | RSS: Main: 204042240 05:28:02 INFO - PROCESS | 6390 | 05:31:04 INFO - PROCESS | 6390 | Cycle 1(1): loaded http://localhost:59383/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59383/tests/dromaeo/cssquery-yui.html) 05:31:05 INFO - PROCESS | 6390 | RSS: Main: 201031680 05:31:05 INFO - PROCESS | 6390 | 05:34:07 INFO - PROCESS | 6390 | Cycle 1(1): loaded http://localhost:59383/tests/dromaeo/cssquery-yui.html (next: http://localhost:59383/tests/dromaeo/cssquery-dojo.html) 05:34:08 INFO - PROCESS | 6390 | RSS: Main: 266637312 05:34:08 INFO - PROCESS | 6390 | 05:34:08 INFO - PROCESS | 6390 | __start_tp_report 05:34:08 INFO - PROCESS | 6390 | _x_x_mozilla_page_load 05:34:08 INFO - PROCESS | 6390 | _x_x_mozilla_page_load_details 05:34:08 INFO - PROCESS | 6390 | |i|pagename|runs| 05:34:08 INFO - PROCESS | 6390 | |0;dojo.html;2642.722514136016;2726.5910113482973;2741.8766155523;2746.58801179823;2774.3341598016477;4586.7477288749105;4677.064587082588;4710.811567537298;4739.431268247807;4766.642501812361;4675.509071547481;4722.268048452487;4756.310335001423;4763.571278584926;4767.1419144553965;4246.596573325544;4283.657307415415;4298.914021719564;4323.373110898918;4430.667699922503;4364.367166760818;4385.42989411376;4391.0559229765595;4437.711548749321;4441.777911104448;4186.120914607936;4280.828766849322;4283.400323954649;4351.456067991485;4363.825446982117;4282.379055037033;4286.335617979218;4313.870583882489;4329.177456283296;4354.869353919387;4263.147370525907;4269.402283680287;4276.850310239127;4294.484661840568;4313.633341166004;4454.554544545552;4568.817247310137;4574.359589657451;4615.607673347769;4647.279671650899;5010.3737032870895;5011.448740638527;5016.49835016499;5019.397672279313;5030.320906677588;5017.172166592508;5032.370953630796;5033.068882256757;5082.4663410341755;5086;4586.472555656075;4631.907361852812;4671.462781780105;4709.7174169549935;4717.433907931001;5148.0476111919415;5156.871078223075;5157.484251574812;5164.715940623302;5226.738663066907;4951.084049450863;4963.90072198554;4965.32968049316;4968.205087186033;4969.329140566049;4862.586680132228;5038.269450929668;5081.161608334583;5107.489251074937;5127.974360128175;4981.277714731344;5021.7740201690285;5031.823886163967;5032.723200224023;5081.974590127025;4838.346823178826;4997.9500204997485;5007.674501157486;5010.924836127461;5017.4731653175895;4216.894577635584;4250.808713607833;4256.2551553478015;4290.077633308853;4295.226859165317;3737.271232109767;3739.102615372291;3742.5883152853166;3754.1740817020213;3776.4712940188397;4203.495580530356;4290.120525292307;4302.870913872589;4306.267934451151;4351.412559304454;4978.103941290602;5007.1487847065355;5021.899562008739;5044.419891712427;5050.696958182521;4294.677899157576;4318.676099292566;4321.546237645065;4341.826326946887;4375.649948004152;4382.627476664519;4530.864074077783;4545.8408955687055;4547.772611369418;4557.407537020233;4734.100520901018;4746.311784791117;4756.048790242035;4762.238041913277;4797.95202047989;4989.625778066732;5009.423916249532;5010.3737032870895;5012.223105418666;5053.8736531587;4600.309953506867;4738.431388233296;4755.286706993978;4787.3537072496165;4819.566239038503;4959.727215003065;4967.254911763264;4968.677035992649;4988.052270068675;4992.101421744121;5078.593712503065;5082.923756143735;5096.694198348111;5098.209777484496;5111.028904508132;4715.363425937455;4855.1260773061185;4923.665825395711;4933.33399991011;4940.086084074458;4875.1712208923855;4887.437944636412;4901;4902.1911384621135;4956.231784073474;4829.879253018562;4830.661853670209;4839.854804355875;4841.443234027991;4897.608191344755;4790.449098353734;4872.780724867461;4926.359573255454;4947.901041979212;4968.27959945813;4820.963492849054;4826.806927722992;4834.709917404967;4836.516348365276;4889.608831293417 05:34:08 INFO - PROCESS | 6390 | |1;ext.html;535.7856857257096;545.78168732507;569.8404446754907;574.3022227992989;621.5027977617905;26754;37853;38178.4273235901;38264;38321.42517862234;31995.52006719901;32310.515342269886;32318;32337.191570210758;32390.514142287826;7758.14660387357;7954.045514538264;7957.840843183133;7960.562169080698;7964.442489025771;7740.380769538451;7876.173001834811;7891.8027049323655;7891.8421631567335;7892.052953645571;7794.493357931717;7889.250521200477;7893.921060789405;7894.447388682795;7894.565798881059;7821.139674635786;7896.605169741519;7902.091259505116;7912.683492660287;7925.564093974829;7814.921850781533;7942.3646108311195;7945.324647404977;7947.165547617475;7952.960235198845;38361.42457863134;38855.80572097121;38880;38913;38925.41611875824;3194.105650417887;3282.5404443377947;3295.703386695185;3374.8650053997812;3622.5109610202812;28740.42519149605;29111.12666620005;29212.853935730185;29907.401851963055;30073.398532029456;3223.564818749462;3260.2175477885376;3267.6405595384726;3320.0537846713814;3420.521127042216;235724;236382;237488;237546.99999999828;238570;48826.51173488291;53416;54516.72741636346;54528.27453117366;54650.72674636601;59155.70422147862;59628.403715963155;59902.40097599055;59962.70018649879;59977;14279.500217492337;14533.273336333352;14539;14541.345639446039;14557.708845823025;10228.948855255825;10902;11045.39250341239;11046.447677616086;11140.61007864737;18194.636107278046;18282.90858545699;18332.816671833378;18426.078696065142;18598.81401185998;7137.286271372925;7246.311600398059;7292.270772922771;7332.560046397233;7363.8159046024275;899.5906862377602;912.7900582865979;915.9862602060974;919.2691810011057;926.8795056642593;26808.195754127406;26956.050134591456;27353.86323068372;27540.862295688796;27788;970.9708708738749;1009.4145395670494;1017.0541396501177;1062.5484169228203;1092.5738961804902;13799.86200138006;14401.855981440262;14501.03046706234;14550.563483095524;14636;270305;273073;273814;274117;274793;46045.53954460412;46613.766931165126;46638;46820;47016.294755578696;1200.8924337787128;1224.253205544617;1236.5857437758273;1247.0335489995146;1249.9500019999098;26236.8688156558;26660.8666956664;26747.19758407251;27506.312342191606;27527.31181720473;41085.58914410818;41355.58644413517;41411.585884141976;41504.58495415007;41527;252535;253317;253418;253503;254049;26902.461950760484;30485.69514304917;30967.380652386375;31492.370152596362;31580.526292106097;35231.47152792761;35567.46648800218;35775.46336804898;35847;36093.819530902176;30263.243418914702;30532.847335763177;32635.18412039718;32822.835885820416;32972;32648.673513264563;32700.50949235716;32851.178720532174;33010.504842426904;33348.1662958428;32345.51481727729;32776;33009.50485742668;33152.17119571933;33203;29459.263518412212;29542.40915181727;30004;30014.24964375821;30064.84967575148;23436;23582.52834943257;23865.8067096641;23957.640635390133;23990.920408581307 05:34:08 INFO - PROCESS | 6390 | |2;jquery.html;337.67245771601546;337.9273456206915;343.9518467414562;345.99999999999994;347.6141482953922;14714.411423543059;15282.159481228528;15895.761563576541;16506.752398713998;16659.50021499354;10262.948685256562;10654.893451065487;10660.093892019167;16136.83863161368;16509.752353714703;4478.820847166109;4606.170889239936;4613.238815595423;4624.09830083134;4631.814727410916;4421.336799480087;4534.274516077428;4580.244259697146;4583.679142460029;4625.144348295559;4498.437695288089;4527.864164075083;4534.863954081383;4535.614472769818;4548.977255113737;4565.589096981287;4569.954300457002;4572.771361431932;4573.794179261941;4575.542445755431;4872.293517439952;5058.570021548173;5073.365829271341;5074.035933172685;5074.340335756365;19095.14071866769;19241.51896202606;19668.606627867506;19887.602247955103;19896.20415183391;1808.5569035586234;1939.8933058681907;1940.3208876892975;2042.1627132875449;2308.5382923415386;9458.716238512856;9466.432014079177;11434.183892229272;12303.507859685602;12720.236785792882;1750.6061136244243;1753.8684598655152;1758.0594382005565;1777.79555351135;1803.846673032794;57658;57796.13305800416;58781;60567.69716151435;60673;9349.53252337394;9459.858102128474;9632.181264592447;9657.32398732096;9669.516524173763;12631.494740210472;12687.492500299884;12760.680982975315;12800;12833;6882.793516194522;7026.859462810715;7072.681729322193;7086.149662040588;7135.750248741373;6753.1220941277315;6779.2881747416795;6817.147856517935;6830.8633827324165;6887.862242755117;4244.639205667491;4302.870913872589;4311.267084595626;4337.414449049401;4370.431843860278;1728.2914005257785;1783.9464816055538;1818.9909050454662;1823.5896923192176;1833.120102350879;830.4270053662954;860.2214995429147;864.6584599083452;917.8645478547515;923.3213588012806;15568.844311556739;15817.841821581636;16128.112953787655;16280.185990700418;16481.505554833373;824.6454024769407;839.6221700234919;842.3429724814654;851.0765819086237;857.9571021448903;8427.115152908857;9328.906710932804;9932.702018939442;9946.701598952042;10103.797924041479;375712;383014;394761;395228;398358.0738866758;71033;71580;72336.27663723295;72389;73434.26565734381;960.7886265021684;969.5443141723379;987.9231637515143;988.0613417253494;1006.9144122749502;14909.850901490847;15204.315805788987;15265.23673816327;15376.538703838904;15389.153596552296;32810.50784238191;34808.47787283243;34828.12929676778;35582;36286.818565907;46693.53306467028;48914;48968.51031489782;49002;49540.25689614731;7528.811779705332;7644.273793989562;7684.731034413769;7703.229677032252;7764.92235077642;10649.307794993301;11019.779604408028;11087.946645068705;11565.421728913689;11573.826392603949;10244.334118282586;10367.585296588051;10380.169586432916;10476.266661333633;10539.841902371318;9596.280278978966;10176.847347289648;10240.64157754475;10343;10392.688219353431;10252.513385558903;10461.581536738446;10504.159667226757;10768.676939691823;10797.514111865143;7492.887606686013;7535.660895259617;7544.0569928758905;7570.205128461653;7596.164421913474;10434.530446130095;10475.371477711362;10529.842052369067;10629.89370106289;10691.679249622524 05:34:08 INFO - PROCESS | 6390 | |3;mootools.html;1315.4212146655477;1386.4869998100703;1412.6821465170335;1553.5339398180543;1785.1431312969767;7044.823879403018;7283.562986220823;7314.926850731497;7323.231060738625;7333.339999400053;7084.822879428017;7201.927980720191;7206.351428371446;7209.423246140309;7215.711371545131;1907.761529808774;1944.8541359398102;2178.6187417202004;2216.8891555422247;2242.7420846602604;2245.595792757303;2247.2696373678536;2251.5722012817596;2252.222983070846;2252.324302709189;2155.353393981807;2188.5294661647745;2199.0324257326806;2232.5646498932715;2234.1175235781857;2157.1155826111376;2157.9352619421443;2159.2442645074257;2161.7405911290666;2164.285785690718;2095.0153427888868;2125.2774056820754;2125.7130287411155;2127.702121702963;2130.403487023636;7479.5886226257535;7546.434017448659;7546.434017448713;7553.773386798405;7563.205863384321;4591.655625828076;4671.766411679437;4684.836030738942;4712.552307530779;4715.693479923828;2816.464871674396;3012.969870301291;3018.0945716285028;3023.5313526403443;3041.300500884809;898.8606765951288;922.8800255966681;931.855562387831;934.7709811096257;953.6566835939057;10158.949205253926;10188.337758045704;10190.89809101907;10203.234757393226;10213.948930255301;4124.4019617155345;4191.685623578243;4233.576642335742;4261.403403523509;4266.701330906807;8696.869546956801;8732.738017859474;8753.562321883881;8756.51839148853;8760.386772925835;4710.24636058229;4710.6702530823195;4723.622110231173;4726.149293127201;4728.0780247851335;3746.138388170736;3965.643092121723;4089.1208390195657;4104.8768536943935;4255.702100852973;3514.7539672222697;3565.2691198304287;3590.6947909427467;3593.7843729376323;3606.3508568457405;1153.7231064544617;1166.2827361172817;1168.526746667601;1177.3583397048628;1187.5240124340846;980.4558470049191;990.2968892086699;994.264244459095;996.5764550066193;1042.8748550173875;7016.859662806715;7019.4384449243935;7024.4029257513685;7086.893696594555;7088.92911070893;455.62866263995403;456.22441848857073;456.76020089453306;457.93131030345717;468.5759387754088;5306.495882891119;5309.495597918191;5313.0967735485065;5323.893522129613;5352.705601191894;8471.576421178916;8671.436356636925;8697.652093916298;8698.95650521756;8705.260052895448;8654.35092368075;8676.739697809076;8697.95651021741;8698;8698.91301086981;6730;7049.189343225492;7054.823629409203;7093.042439270633;7120.359167674934;6931.445484361138;6962.060121883684;6986.720531178696;6990.580565166107;7160.534565253241;7967.402444816546;8071.394645401736;8186.3860210485645;8210.712625058095;8327.292180164754;8415;8418.410711250153;8481.06708262103;8506.191911768372;8572.485650860968;5794.101914203306;6217.564770466024;6269.780557680641;6395.712192951235;6446.129772480655;7030.3321184487395;7052.788416347517;7071.752488662872;7091.468139889632;7114.253003434772;6266.624002559861;6324.905126423199;6335.90496142549;6495.935040649722;6566.671666416564;6354.52341074412;6356.141920840627;6405.807825765234;6470.708818103102;6560.081588577507;6760.695768690519;6788.456923446014;6811.795646130624;6813.8977915330315;6830.556013859084;6092.360302168208;6105.481034111973;6167.660778657217;6259.906101408574;6272.655003974825;6349.619022858643;6353.555251132377;6388.840278993062;6413.807585772434;6423.646699431576 05:34:08 INFO - PROCESS | 6390 | |4;prototype.html;312.8107494965546;313.20602273237347;314.3194982862104;317.75691595929106;320.31612507296916;5288.894222115556;5349.652272602283;5362.758675859586;5425.13197888338;5425.186222066692;5292.894142117165;5308.495692909168;5312.07038768216;5316.49493298137;5324.094903866342;3920.705947053968;4013.076992291775;4160.022394737234;4170.72890262132;4173.56177601352;4167;4168.62482376586;4170.728902621335;4171.937420938689;4172.77049762263;4130.896727581804;4139.461869956901;4142.420061191436;4142.606452387018;4144.6684265258855;3928.960710392888;4047.5345335286524;4133.81397837095;4145.97927010366;4147.108371700099;3633.5276414066266;3649.1424515238896;3651.8174091295327;3654.3604869148057;3656.8537258509627;5142.897142057175;5148.3564554430695;5153.5361817436615;5157.149070403379;5161.81933632321;4788.497207793202;4802.207635740098;4803.519648035203;4806.303086052538;4807.975960120212;5646.632968857011;5649.745761440745;5654.858628534278;5655.604107712462;5659.688717120557;4012.8996775080564;4016.176683779818;4018.9196216075516;4021.336479480882;4022.879313620596;5734.483896449339;5849.707514624251;5920.437558431942;5924.081767326072;5925.674087925162;4107.158032603309;4117.814698338582;4129.359949207877;4130.731502452331;4137.193247316744;4165.083681590046;4170.35359519275;4176.7076304658385;4187.413762073312;4190.099128687347;4750.501197374226;4755;4757.072370887644;4757.072370887644;4765;5615.382307946123;5616.241807356037;5619.409961953936;5621.522170615462;5622.718864056781;1449.8985071045136;1477.18754684925;1479.0090639271714;1479.2381923309504;1482.7256957462903;887.9822403551893;925.287528602972;946.0586716217271;955;991.7471044883508;4820.68665536739;4907.7300748458465;4931.90136197274;4933.136701077369;4936.6297527685565;5791.88416231673;5810.767569297265;5823.30120385548;5824.0390335595;5824.388439213906;4911.435184953704;4918.213085906309;4920.3603531541385;4927.827526036572;4929.679570827885;3109.0983614751467;3151.6218053833686;3156.337169194495;3156.952645710316;3157.984210078981;5521.69630670317;5526.47498487643;5527.032769265443;5527.364353099445;5533.335999680065;5827.388124246893;5972.283326000907;5988.550858685616;6001.2498437695285;6009.1587177795145;5481.616286859961;5504.559635229172;5514.834554963438;5519.282493275929;5523.199136125159;5868.706564671835;5874.353821079763;5874.794382196774;5879.559033072622;5933.821985340447;5729.627574207663;5731.168980497888;5739.598228123991;5746.626469279484;5750.424957504216;5358.437364076716;5503.11950087984;5504.587155963239;5506.807261745819;5511.53151982086;3995.2808494471274;4000.9199816002933;4003.939940900947;4005.2790497709525;4007.479027726377;5792.507636850746;5828.388019257917;5846.94153058464;5854.092615644582;5892.793752218652;5643.830685079454;5650.350209725934;5652.745626446737;5652.7738890443925;5657.066584013592;5600.691961942132;5649;5655.3213614364895;5659.886802264014;5663.782286808356;5342.519173274424;5567.777288908398;5580.330360356783;5590.440955904377;5591.440855914539;5632.774689012557;5652.434756524479;5656.575756818337;5657.886842263214;5663.858403539944;5522.806701765419;5529.087700529529;5536.612437129363;5585.888282234414;5590.692511911721 05:34:08 INFO - PROCESS | 6390 | |5;yui.html;761.4707778094224;761.8209720715635;773.3619763694946;779.7855589712829;796.6494742313382;14035.78946315806;14276;14292.571222863318;14298.714025719506;14303.928480357583;13507.459701611924;13755.587332380019;13764.242966636832;13854.653633659163;13861.099028563136;651.4039653716843;801.4910531812312;812.5733989655419;845.7674139611595;847.9491230526188;792.0455850699922;826.5454000299811;834.7454026521908;838.4256784102879;838.6435764799966;826.3430572694692;864.6584599083359;873.2097451806094;873.4235404632943;873.4322690251356;675.9155105611799;838.0655569040537;867.9999999999968;869.217704066339;869.3697069624535;600.3246347858659;611.6972098811073;633.882731694638;634.5431289471574;634.5716641267172;11894.52421903123;11910.642680719593;11972.461239244254;11998;12025.158238923279;11674.241174323726;12135.575254866126;12165.51337946481;12206.755864882653;12484.687882802911;9909.75225619358;9916.851247231225;9922.851157232648;10038.749031274203;10068.043535864155;3239.757018223619;3256.3161736035463;3317.834108294576;3340.43212653847;3375.206826395795;44281.77859110748;45168.3224751629;45231.321530177076;45760.54239457596;45790.54209457896;9492.050794920453;9643.758906027266;9664.08191221847;9894.55474503649;9931.900680993242;16781.328746850235;16814.411495597597;16816.915915420344;16839.07385093807;16839.326426942785;6548.738050477928;6560.540762146699;6632.403083722488;6653.900191497131;6761.729530818712;3530.0998245447245;3554.0759402555004;3702.33357995558;3711.9072023199637;3716.4611131385795;2646.8147229694123;2668.8932442702076;2670.5593577059567;2673.31830383251;2674.665666791651;479.549223729693;481.58343033275963;490.43109992408637;490.94108706955393;523.1551045062197;544.4881811097634;597.5249676507187;619.5479777953987;634.4860662863096;640.5036097024843;7100.325469080429;7294.161171465349;7392.075990501187;7425;7525.9386243807985;551.6910530103155;554.4344768336274;555.4279092534696;559.3427722426133;566.0744682444233;3413.906414952238;3475.374432602156;3507.2810073934784;3539.9292014159573;3543;51898.740506297225;52451.47548524542;52766.73616631892;52874.206886896725;52925.735371323666;45774;46131;46183;47470.5252947473;47788.5221147791;41788.37317440241;42616.78691606522;42792;43335.13329733388;43556.78221608935;7003.264657211123;7036.472264580075;7051.435885129074;7081.185663648746;7178.928210717826;32153.196170095936;32977.175570610925;33011.44669975042;33208.833955830065;33414.66585334213;38291.808540958235;38720.80639596784;38744.2251154981;41394;41490.58509414867;8634.136586341316;8801.779955501164;8809.911900881165;8904.777380565538;9049.864252036356;8661.657443096077;9150.588223529823;9218.308626853148;9385.812283754423;11404.657860264206;10178.949105254427;10199.38803671782;10255.128314093387;10348.586056557653;10836.187285953427;10347.896521034994;10563.894361056291;10817.729556761144;10932.125429965743;11168.553257869595;10770.784584308427;10909.39998300101;10977.945110274397;11205.887941120485;11350.432478375884;9098.727038188865;9234.076592340982;9260.39807412516;9794.75513112178;9852.310338276251;9223.308251881002;9344.95327523358;9362.625494980124;9543.42739435636;9554.474503902075 05:34:08 INFO - PROCESS | 6390 | __end_tp_report 05:34:08 INFO - PROCESS | 6390 | __start_cc_report 05:34:08 INFO - PROCESS | 6390 | _x_x_mozilla_cycle_collect,1014 05:34:08 INFO - PROCESS | 6390 | __end_cc_report 05:34:08 INFO - PROCESS | 6390 | __startTimestamp1459946048236__endTimestamp 05:34:08 INFO - PROCESS | 6390 | 05:34:08 INFO - PROCESS | 6390 | ------- Summary: start ------- 05:34:08 INFO - PROCESS | 6390 | Number of tests: 6 05:34:08 INFO - PROCESS | 6390 | 05:34:08 INFO - PROCESS | 6390 | [#0] dojo.html Cycles:165 Average:4647.70 Median:4767.14 stddev:476.86 (10.0%) stddev-sans-first:451.64 05:34:08 INFO - PROCESS | 6390 | Values: 2642.7 2726.6 2741.9 2746.6 2774.3 4586.7 4677.1 4710.8 4739.4 4766.6 4675.5 4722.3 4756.3 4763.6 4767.1 4246.6 4283.7 4298.9 4323.4 4430.7 4364.4 4385.4 4391.1 4437.7 4441.8 4186.1 4280.8 4283.4 4351.5 4363.8 4282.4 4286.3 4313.9 4329.2 4354.9 4263.1 4269.4 4276.9 4294.5 4313.6 4454.6 4568.8 4574.4 4615.6 4647.3 5010.4 5011.4 5016.5 5019.4 5030.3 5017.2 5032.4 5033.1 5082.5 5086.0 4586.5 4631.9 4671.5 4709.7 4717.4 5148.0 5156.9 5157.5 5164.7 5226.7 4951.1 4963.9 4965.3 4968.2 4969.3 4862.6 5038.3 5081.2 5107.5 5128.0 4981.3 5021.8 5031.8 5032.7 5082.0 4838.3 4998.0 5007.7 5010.9 5017.5 4216.9 4250.8 4256.3 4290.1 4295.2 3737.3 3739.1 3742.6 3754.2 3776.5 4203.5 4290.1 4302.9 4306.3 4351.4 4978.1 5007.1 5021.9 5044.4 5050.7 4294.7 4318.7 4321.5 4341.8 4375.6 4382.6 4530.9 4545.8 4547.8 4557.4 4734.1 4746.3 4756.0 4762.2 4798.0 4989.6 5009.4 5010.4 5012.2 5053.9 4600.3 4738.4 4755.3 4787.4 4819.6 4959.7 4967.3 4968.7 4988.1 4992.1 5078.6 5082.9 5096.7 5098.2 5111.0 4715.4 4855.1 4923.7 4933.3 4940.1 4875.2 4887.4 4901.0 4902.2 4956.2 4829.9 4830.7 4839.9 4841.4 4897.6 4790.4 4872.8 4926.4 4947.9 4968.3 4821.0 4826.8 4834.7 4836.5 4889.6 05:34:08 INFO - PROCESS | 6390 | 05:34:08 INFO - PROCESS | 6390 | [#1] ext.html Cycles:180 Average:41324.44 Median:18029.27 stddev:66470.29 (368.7%) stddev-sans-first:66586.20 05:34:08 INFO - PROCESS | 6390 | Values: 535.8 545.8 569.8 574.3 621.5 26754.0 37853.0 38178.4 38264.0 38321.4 31995.5 32310.5 32318.0 32337.2 32390.5 7758.1 7954.0 7957.8 7960.6 7964.4 7740.4 7876.2 7891.8 7891.8 7892.1 7794.5 7889.3 7893.9 7894.4 7894.6 7821.1 7896.6 7902.1 7912.7 7925.6 7814.9 7942.4 7945.3 7947.2 7953.0 38361.4 38855.8 38880.0 38913.0 38925.4 3194.1 3282.5 3295.7 3374.9 3622.5 28740.4 29111.1 29212.9 29907.4 30073.4 3223.6 3260.2 3267.6 3320.1 3420.5 235724.0 236382.0 237488.0 237547.0 238570.0 48826.5 53416.0 54516.7 54528.3 54650.7 59155.7 59628.4 59902.4 59962.7 59977.0 14279.5 14533.3 14539.0 14541.3 14557.7 10228.9 10902.0 11045.4 11046.4 11140.6 18194.6 18282.9 18332.8 18426.1 18598.8 7137.3 7246.3 7292.3 7332.6 7363.8 899.6 912.8 916.0 919.3 926.9 26808.2 26956.1 27353.9 27540.9 27788.0 971.0 1009.4 1017.1 1062.5 1092.6 13799.9 14401.9 14501.0 14550.6 14636.0 270305.0 273073.0 273814.0 274117.0 274793.0 46045.5 46613.8 46638.0 46820.0 47016.3 1200.9 1224.3 1236.6 1247.0 1250.0 26236.9 26660.9 26747.2 27506.3 27527.3 41085.6 41355.6 41411.6 41504.6 41527.0 252535.0 253317.0 253418.0 253503.0 254049.0 26902.5 30485.7 30967.4 31492.4 31580.5 35231.5 35567.5 35775.5 35847.0 36093.8 30263.2 30532.8 32635.2 32822.8 32972.0 32648.7 32700.5 32851.2 33010.5 33348.2 32345.5 32776.0 33009.5 33152.2 33203.0 29459.3 29542.4 30004.0 30014.2 30064.8 23436.0 23582.5 23865.8 23957.6 23990.9 05:34:08 INFO - PROCESS | 6390 | 05:34:08 INFO - PROCESS | 6390 | [#2] jquery.html Cycles:180 Average:23463.45 Median:4307.07 stddev:64048.40 (1487.1%) stddev-sans-first:64204.53 05:34:08 INFO - PROCESS | 6390 | Values: 337.7 337.9 344.0 346.0 347.6 14714.4 15282.2 15895.8 16506.8 16659.5 10262.9 10654.9 10660.1 16136.8 16509.8 4478.8 4606.2 4613.2 4624.1 4631.8 4421.3 4534.3 4580.2 4583.7 4625.1 4498.4 4527.9 4534.9 4535.6 4549.0 4565.6 4570.0 4572.8 4573.8 4575.5 4872.3 5058.6 5073.4 5074.0 5074.3 19095.1 19241.5 19668.6 19887.6 19896.2 1808.6 1939.9 1940.3 2042.2 2308.5 9458.7 9466.4 11434.2 12303.5 12720.2 1750.6 1753.9 1758.1 1777.8 1803.8 57658.0 57796.1 58781.0 60567.7 60673.0 9349.5 9459.9 9632.2 9657.3 9669.5 12631.5 12687.5 12760.7 12800.0 12833.0 6882.8 7026.9 7072.7 7086.1 7135.8 6753.1 6779.3 6817.1 6830.9 6887.9 4244.6 4302.9 4311.3 4337.4 4370.4 1728.3 1783.9 1819.0 1823.6 1833.1 830.4 860.2 864.7 917.9 923.3 15568.8 15817.8 16128.1 16280.2 16481.5 824.6 839.6 842.3 851.1 858.0 8427.1 9328.9 9932.7 9946.7 10103.8 375712.0 383014.0 394761.0 395228.0 398358.1 71033.0 71580.0 72336.3 72389.0 73434.3 960.8 969.5 987.9 988.1 1006.9 14909.9 15204.3 15265.2 15376.5 15389.2 32810.5 34808.5 34828.1 35582.0 36286.8 46693.5 48914.0 48968.5 49002.0 49540.3 7528.8 7644.3 7684.7 7703.2 7764.9 10649.3 11019.8 11087.9 11565.4 11573.8 10244.3 10367.6 10380.2 10476.3 10539.8 9596.3 10176.8 10240.6 10343.0 10392.7 10252.5 10461.6 10504.2 10768.7 10797.5 7492.9 7535.7 7544.1 7570.2 7596.2 10434.5 10475.4 10529.8 10629.9 10691.7 05:34:08 INFO - PROCESS | 6390 | 05:34:08 INFO - PROCESS | 6390 | [#3] mootools.html Cycles:180 Average:5189.81 Median:6330.41 stddev:2705.34 (42.7%) stddev-sans-first:2697.26 05:34:08 INFO - PROCESS | 6390 | Values: 1315.4 1386.5 1412.7 1553.5 1785.1 7044.8 7283.6 7314.9 7323.2 7333.3 7084.8 7201.9 7206.4 7209.4 7215.7 1907.8 1944.9 2178.6 2216.9 2242.7 2245.6 2247.3 2251.6 2252.2 2252.3 2155.4 2188.5 2199.0 2232.6 2234.1 2157.1 2157.9 2159.2 2161.7 2164.3 2095.0 2125.3 2125.7 2127.7 2130.4 7479.6 7546.4 7546.4 7553.8 7563.2 4591.7 4671.8 4684.8 4712.6 4715.7 2816.5 3013.0 3018.1 3023.5 3041.3 898.9 922.9 931.9 934.8 953.7 10158.9 10188.3 10190.9 10203.2 10213.9 4124.4 4191.7 4233.6 4261.4 4266.7 8696.9 8732.7 8753.6 8756.5 8760.4 4710.2 4710.7 4723.6 4726.1 4728.1 3746.1 3965.6 4089.1 4104.9 4255.7 3514.8 3565.3 3590.7 3593.8 3606.4 1153.7 1166.3 1168.5 1177.4 1187.5 980.5 990.3 994.3 996.6 1042.9 7016.9 7019.4 7024.4 7086.9 7088.9 455.6 456.2 456.8 457.9 468.6 5306.5 5309.5 5313.1 5323.9 5352.7 8471.6 8671.4 8697.7 8699.0 8705.3 8654.4 8676.7 8698.0 8698.0 8698.9 6730.0 7049.2 7054.8 7093.0 7120.4 6931.4 6962.1 6986.7 6990.6 7160.5 7967.4 8071.4 8186.4 8210.7 8327.3 8415.0 8418.4 8481.1 8506.2 8572.5 5794.1 6217.6 6269.8 6395.7 6446.1 7030.3 7052.8 7071.8 7091.5 7114.3 6266.6 6324.9 6335.9 6495.9 6566.7 6354.5 6356.1 6405.8 6470.7 6560.1 6760.7 6788.5 6811.8 6813.9 6830.6 6092.4 6105.5 6167.7 6259.9 6272.7 6349.6 6353.6 6388.8 6413.8 6423.6 05:34:08 INFO - PROCESS | 6390 | 05:34:08 INFO - PROCESS | 6390 | [#4] prototype.html Cycles:180 Average:4680.13 Median:5333.31 stddev:1369.83 (25.7%) stddev-sans-first:1333.88 05:34:08 INFO - PROCESS | 6390 | Values: 312.8 313.2 314.3 317.8 320.3 5288.9 5349.7 5362.8 5425.1 5425.2 5292.9 5308.5 5312.1 5316.5 5324.1 3920.7 4013.1 4160.0 4170.7 4173.6 4167.0 4168.6 4170.7 4171.9 4172.8 4130.9 4139.5 4142.4 4142.6 4144.7 3929.0 4047.5 4133.8 4146.0 4147.1 3633.5 3649.1 3651.8 3654.4 3656.9 5142.9 5148.4 5153.5 5157.1 5161.8 4788.5 4802.2 4803.5 4806.3 4808.0 5646.6 5649.7 5654.9 5655.6 5659.7 4012.9 4016.2 4018.9 4021.3 4022.9 5734.5 5849.7 5920.4 5924.1 5925.7 4107.2 4117.8 4129.4 4130.7 4137.2 4165.1 4170.4 4176.7 4187.4 4190.1 4750.5 4755.0 4757.1 4757.1 4765.0 5615.4 5616.2 5619.4 5621.5 5622.7 1449.9 1477.2 1479.0 1479.2 1482.7 888.0 925.3 946.1 955.0 991.7 4820.7 4907.7 4931.9 4933.1 4936.6 5791.9 5810.8 5823.3 5824.0 5824.4 4911.4 4918.2 4920.4 4927.8 4929.7 3109.1 3151.6 3156.3 3157.0 3158.0 5521.7 5526.5 5527.0 5527.4 5533.3 5827.4 5972.3 5988.6 6001.2 6009.2 5481.6 5504.6 5514.8 5519.3 5523.2 5868.7 5874.4 5874.8 5879.6 5933.8 5729.6 5731.2 5739.6 5746.6 5750.4 5358.4 5503.1 5504.6 5506.8 5511.5 3995.3 4000.9 4003.9 4005.3 4007.5 5792.5 5828.4 5846.9 5854.1 5892.8 5643.8 5650.4 5652.7 5652.8 5657.1 5600.7 5649.0 5655.3 5659.9 5663.8 5342.5 5567.8 5580.3 5590.4 5591.4 5632.8 5652.4 5656.6 5657.9 5663.9 5522.8 5529.1 5536.6 5585.9 5590.7 05:34:08 INFO - PROCESS | 6390 | 05:34:08 INFO - PROCESS | 6390 | [#5] yui.html Cycles:180 Average:12737.44 Median:490.69 stddev:14665.66 (2988.8%) stddev-sans-first:14679.23 05:34:08 INFO - PROCESS | 6390 | Values: 761.5 761.8 773.4 779.8 796.6 14035.8 14276.0 14292.6 14298.7 14303.9 13507.5 13755.6 13764.2 13854.7 13861.1 651.4 801.5 812.6 845.8 847.9 792.0 826.5 834.7 838.4 838.6 826.3 864.7 873.2 873.4 873.4 675.9 838.1 868.0 869.2 869.4 600.3 611.7 633.9 634.5 634.6 11894.5 11910.6 11972.5 11998.0 12025.2 11674.2 12135.6 12165.5 12206.8 12484.7 9909.8 9916.9 9922.9 10038.7 10068.0 3239.8 3256.3 3317.8 3340.4 3375.2 44281.8 45168.3 45231.3 45760.5 45790.5 9492.1 9643.8 9664.1 9894.6 9931.9 16781.3 16814.4 16816.9 16839.1 16839.3 6548.7 6560.5 6632.4 6653.9 6761.7 3530.1 3554.1 3702.3 3711.9 3716.5 2646.8 2668.9 2670.6 2673.3 2674.7 479.5 481.6 490.4 490.9 523.2 544.5 597.5 619.5 634.5 640.5 7100.3 7294.2 7392.1 7425.0 7525.9 551.7 554.4 555.4 559.3 566.1 3413.9 3475.4 3507.3 3539.9 3543.0 51898.7 52451.5 52766.7 52874.2 52925.7 45774.0 46131.0 46183.0 47470.5 47788.5 41788.4 42616.8 42792.0 43335.1 43556.8 7003.3 7036.5 7051.4 7081.2 7178.9 32153.2 32977.2 33011.4 33208.8 33414.7 38291.8 38720.8 38744.2 41394.0 41490.6 8634.1 8801.8 8809.9 8904.8 9049.9 8661.7 9150.6 9218.3 9385.8 11404.7 10178.9 10199.4 10255.1 10348.6 10836.2 10347.9 10563.9 10817.7 10932.1 11168.6 10770.8 10909.4 10977.9 11205.9 11350.4 9098.7 9234.1 9260.4 9794.8 9852.3 9223.3 9345.0 9362.6 9543.4 9554.5 05:34:08 INFO - PROCESS | 6390 | -------- Summary: end -------- 05:34:08 INFO - PROCESS | 6390 | 05:34:08 INFO - TEST-INFO | 6390: exit 0 05:34:08 INFO - TEST-OK | dromaeo_css | took 1114832ms 05:34:08 INFO - TEST-START | kraken 05:34:08 INFO - operating with platform_type : linux_ 05:34:08 INFO - Initialising browser for kraken test... 05:34:08 INFO - TEST-INFO | started process 6571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPRcfjF/profile http://localhost:59383/getInfo.html) 05:34:12 INFO - PROCESS | 6571 | __metrics Screen width/height:1600/1200 05:34:12 INFO - PROCESS | 6571 | colorDepth:24 05:34:12 INFO - PROCESS | 6571 | Browser inner width/height: 1024/697 05:34:12 INFO - PROCESS | 6571 | __metrics 05:34:13 ERROR - PROCESS | 6571 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:34:14 INFO - TEST-INFO | 6571: exit 0 05:34:14 INFO - Browser initialized. 05:34:14 INFO - Running cycle 1/1 for kraken test... 05:34:14 INFO - TEST-INFO | started process 6652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPRcfjF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:25 INFO - PROCESS | 6652 | RSS: Main: 154718208 05:34:25 INFO - PROCESS | 6652 | 05:34:28 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59383/tests/kraken/driver.html?testName=audio-beat-detection) 05:34:29 INFO - PROCESS | 6652 | RSS: Main: 195526656 05:34:29 INFO - PROCESS | 6652 | 05:34:31 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59383/tests/kraken/driver.html?testName=audio-dft) 05:34:32 INFO - PROCESS | 6652 | RSS: Main: 185200640 05:34:32 INFO - PROCESS | 6652 | 05:34:35 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59383/tests/kraken/driver.html?testName=audio-fft) 05:34:36 INFO - PROCESS | 6652 | RSS: Main: 170668032 05:34:36 INFO - PROCESS | 6652 | 05:34:38 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59383/tests/kraken/driver.html?testName=audio-oscillator) 05:34:38 INFO - PROCESS | 6652 | RSS: Main: 172384256 05:34:38 INFO - PROCESS | 6652 | 05:34:41 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59383/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:41 INFO - PROCESS | 6652 | RSS: Main: 173985792 05:34:41 INFO - PROCESS | 6652 | 05:34:44 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59383/tests/kraken/driver.html?testName=imaging-darkroom) 05:34:45 INFO - PROCESS | 6652 | RSS: Main: 174292992 05:34:45 INFO - PROCESS | 6652 | 05:34:48 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59383/tests/kraken/driver.html?testName=imaging-desaturate) 05:34:49 INFO - PROCESS | 6652 | RSS: Main: 174944256 05:34:49 INFO - PROCESS | 6652 | 05:34:52 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59383/tests/kraken/driver.html?testName=json-parse-financial) 05:34:52 INFO - PROCESS | 6652 | RSS: Main: 173948928 05:34:52 INFO - PROCESS | 6652 | 05:34:54 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59383/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:34:55 INFO - PROCESS | 6652 | RSS: Main: 183586816 05:34:55 INFO - PROCESS | 6652 | 05:34:56 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59383/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:34:57 INFO - PROCESS | 6652 | RSS: Main: 181370880 05:34:57 INFO - PROCESS | 6652 | 05:34:59 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59383/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:35:00 INFO - PROCESS | 6652 | RSS: Main: 196538368 05:35:00 INFO - PROCESS | 6652 | 05:35:02 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59383/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:35:03 INFO - PROCESS | 6652 | RSS: Main: 200585216 05:35:03 INFO - PROCESS | 6652 | 05:35:05 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59383/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:35:06 INFO - PROCESS | 6652 | RSS: Main: 199790592 05:35:06 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:59383/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59383/tests/kraken/driver.html?testName=ai-astar) 05:35:08 INFO - PROCESS | 6652 | RSS: Main: 262508544 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | __start_tp_report 05:35:08 INFO - PROCESS | 6652 | _x_x_mozilla_page_load 05:35:08 INFO - PROCESS | 6652 | _x_x_mozilla_page_load_details 05:35:08 INFO - PROCESS | 6652 | |i|pagename|runs| 05:35:08 INFO - PROCESS | 6652 | |0;ai-astar;112;114;108;112;113;113;102;113;113;111 05:35:08 INFO - PROCESS | 6652 | |1;audio-beat-detection;159;136;155;187;131;159;151;133;184;138 05:35:08 INFO - PROCESS | 6652 | |2;audio-dft;163;163;161;161;161;160;161;165;162;163 05:35:08 INFO - PROCESS | 6652 | |3;audio-fft;76;74;108;104;74;74;73;112;99;74 05:35:08 INFO - PROCESS | 6652 | |4;audio-oscillator;93;95;139;93;93;94;135;94;95;141 05:35:08 INFO - PROCESS | 6652 | |5;imaging-gaussian-blur;118;117;116;118;117;116;117;117;116;117 05:35:08 INFO - PROCESS | 6652 | |6;imaging-darkroom;146;146;146;146;145;146;145;145;145;145 05:35:08 INFO - PROCESS | 6652 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 05:35:08 INFO - PROCESS | 6652 | |8;json-parse-financial;65;65;67;66;67;67;66;74;63;63 05:35:08 INFO - PROCESS | 6652 | |9;json-stringify-tinderbox;64;63;62;64;64;64;64;64;64;64 05:35:08 INFO - PROCESS | 6652 | |10;stanford-crypto-aes;82;83;92;84;83;86;92;83;86;91 05:35:08 INFO - PROCESS | 6652 | |11;stanford-crypto-ccm;124;124;118;116;126;120;127;119;128;128 05:35:08 INFO - PROCESS | 6652 | |12;stanford-crypto-pbkdf2;146;131;142;142;144;143;141;141;149;145 05:35:08 INFO - PROCESS | 6652 | |13;stanford-crypto-sha256-iterative;70;67;68;69;66;69;69;69;68;66 05:35:08 INFO - PROCESS | 6652 | __end_tp_report 05:35:08 INFO - PROCESS | 6652 | __start_cc_report 05:35:08 INFO - PROCESS | 6652 | _x_x_mozilla_cycle_collect,1190 05:35:08 INFO - PROCESS | 6652 | __end_cc_report 05:35:08 INFO - PROCESS | 6652 | __startTimestamp1459946108589__endTimestamp 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | ------- Summary: start ------- 05:35:08 INFO - PROCESS | 6652 | Number of tests: 14 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:3.60 (3.2%) stddev-sans-first:3.81 05:35:08 INFO - PROCESS | 6652 | Values: 112.0 114.0 108.0 112.0 113.0 113.0 102.0 113.0 113.0 111.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#1] audio-beat-detection Cycles:10 Average:153.30 Median:157.00 stddev:19.98 (12.7%) stddev-sans-first:21.09 05:35:08 INFO - PROCESS | 6652 | Values: 159.0 136.0 155.0 187.0 131.0 159.0 151.0 133.0 184.0 138.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.49 (0.9%) stddev-sans-first:1.54 05:35:08 INFO - PROCESS | 6652 | Values: 163.0 163.0 161.0 161.0 161.0 160.0 161.0 165.0 162.0 163.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#3] audio-fft Cycles:10 Average:86.80 Median:74.00 stddev:16.64 (22.5%) stddev-sans-first:17.18 05:35:08 INFO - PROCESS | 6652 | Values: 76.0 74.0 108.0 104.0 74.0 74.0 73.0 112.0 99.0 74.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:93.50 stddev:21.54 (23.0%) stddev-sans-first:22.23 05:35:08 INFO - PROCESS | 6652 | Values: 93.0 95.0 139.0 93.0 93.0 94.0 135.0 94.0 95.0 141.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 05:35:08 INFO - PROCESS | 6652 | Values: 118.0 117.0 116.0 118.0 117.0 116.0 117.0 117.0 116.0 117.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:35:08 INFO - PROCESS | 6652 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:35:08 INFO - PROCESS | 6652 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.50 stddev:3.09 (4.7%) stddev-sans-first:3.24 05:35:08 INFO - PROCESS | 6652 | Values: 65.0 65.0 67.0 66.0 67.0 67.0 66.0 74.0 63.0 63.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 05:35:08 INFO - PROCESS | 6652 | Values: 64.0 63.0 62.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:3.99 (4.6%) stddev-sans-first:3.94 05:35:08 INFO - PROCESS | 6652 | Values: 82.0 83.0 92.0 84.0 83.0 86.0 92.0 83.0 86.0 91.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:125.00 stddev:4.42 (3.5%) stddev-sans-first:4.68 05:35:08 INFO - PROCESS | 6652 | Values: 124.0 124.0 118.0 116.0 126.0 120.0 127.0 119.0 128.0 128.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.40 Median:143.50 stddev:4.72 (3.3%) stddev-sans-first:4.82 05:35:08 INFO - PROCESS | 6652 | Values: 146.0 131.0 142.0 142.0 144.0 143.0 141.0 141.0 149.0 145.0 05:35:08 INFO - PROCESS | 6652 | 05:35:08 INFO - PROCESS | 6652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.37 (2.0%) stddev-sans-first:1.27 05:35:08 INFO - PROCESS | 6652 | Values: 70.0 67.0 68.0 69.0 66.0 69.0 69.0 69.0 68.0 66.0 05:35:08 INFO - PROCESS | 6652 | -------- Summary: end -------- 05:35:08 INFO - PROCESS | 6652 | 05:35:09 INFO - TEST-INFO | 6652: exit 0 05:35:09 INFO - TEST-OK | kraken | took 60466ms 05:35:09 INFO - SUITE-END | took 1175s 05:35:09 INFO - Completed test suite (00:19:35) 05:35:09 INFO - javascript benchmark 05:35:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2642.722514136016, 2726.5910113482973, 2741.8766155523, 2746.58801179823, 2774.3341598016477, 4586.7477288749105, 4677.064587082588, 4710.811567537298, 4739.431268247807, 4766.642501812361, 4675.509071547481, 4722.268048452487, 4756.310335001423, 4763.571278584926, 4767.1419144553965, 4246.596573325544, 4283.657307415415, 4298.914021719564, 4323.373110898918, 4430.667699922503, 4364.367166760818, 4385.42989411376, 4391.0559229765595, 4437.711548749321, 4441.777911104448, 4186.120914607936, 4280.828766849322, 4283.400323954649, 4351.456067991485, 4363.825446982117, 4282.379055037033, 4286.335617979218, 4313.870583882489, 4329.177456283296, 4354.869353919387, 4263.147370525907, 4269.402283680287, 4276.850310239127, 4294.484661840568, 4313.633341166004, 4454.554544545552, 4568.817247310137, 4574.359589657451, 4615.607673347769, 4647.279671650899, 5010.3737032870895, 5011.448740638527, 5016.49835016499, 5019.397672279313, 5030.320906677588, 5017.172166592508, 5032.370953630796, 5033.068882256757, 5082.4663410341755, 5086.0, 4586.472555656075, 4631.907361852812, 4671.462781780105, 4709.7174169549935, 4717.433907931001, 5148.0476111919415, 5156.871078223075, 5157.484251574812, 5164.715940623302, 5226.738663066907, 4951.084049450863, 4963.90072198554, 4965.32968049316, 4968.205087186033, 4969.329140566049, 4862.586680132228, 5038.269450929668, 5081.161608334583, 5107.489251074937, 5127.974360128175, 4981.277714731344, 5021.7740201690285, 5031.823886163967, 5032.723200224023, 5081.974590127025, 4838.346823178826, 4997.9500204997485, 5007.674501157486, 5010.924836127461, 5017.4731653175895, 4216.894577635584, 4250.808713607833, 4256.2551553478015, 4290.077633308853, 4295.226859165317, 3737.271232109767, 3739.102615372291, 3742.5883152853166, 3754.1740817020213, 3776.4712940188397, 4203.495580530356, 4290.120525292307, 4302.870913872589, 4306.267934451151, 4351.412559304454, 4978.103941290602, 5007.1487847065355, 5021.899562008739, 5044.419891712427, 5050.696958182521, 4294.677899157576, 4318.676099292566, 4321.546237645065, 4341.826326946887, 4375.649948004152, 4382.627476664519, 4530.864074077783, 4545.8408955687055, 4547.772611369418, 4557.407537020233, 4734.100520901018, 4746.311784791117, 4756.048790242035, 4762.238041913277, 4797.95202047989, 4989.625778066732, 5009.423916249532, 5010.3737032870895, 5012.223105418666, 5053.8736531587, 4600.309953506867, 4738.431388233296, 4755.286706993978, 4787.3537072496165, 4819.566239038503, 4959.727215003065, 4967.254911763264, 4968.677035992649, 4988.052270068675, 4992.101421744121, 5078.593712503065, 5082.923756143735, 5096.694198348111, 5098.209777484496, 5111.028904508132, 4715.363425937455, 4855.1260773061185, 4923.665825395711, 4933.33399991011, 4940.086084074458, 4875.1712208923855, 4887.437944636412, 4901.0, 4902.1911384621135, 4956.231784073474, 4829.879253018562, 4830.661853670209, 4839.854804355875, 4841.443234027991, 4897.608191344755, 4790.449098353734, 4872.780724867461, 4926.359573255454, 4947.901041979212, 4968.27959945813, 4820.963492849054, 4826.806927722992, 4834.709917404967, 4836.516348365276, 4889.608831293417], "unit": "score", "name": "dojo.html", "value": 4618.612411091414}, {"lowerIsBetter": false, "replicates": [535.7856857257096, 545.78168732507, 569.8404446754907, 574.3022227992989, 621.5027977617905, 26754.0, 37853.0, 38178.4273235901, 38264.0, 38321.42517862234, 31995.52006719901, 32310.515342269886, 32318.0, 32337.191570210758, 32390.514142287826, 7758.14660387357, 7954.045514538264, 7957.840843183133, 7960.562169080698, 7964.442489025771, 7740.380769538451, 7876.173001834811, 7891.8027049323655, 7891.8421631567335, 7892.052953645571, 7794.493357931717, 7889.250521200477, 7893.921060789405, 7894.447388682795, 7894.565798881059, 7821.139674635786, 7896.605169741519, 7902.091259505116, 7912.683492660287, 7925.564093974829, 7814.921850781533, 7942.3646108311195, 7945.324647404977, 7947.165547617475, 7952.960235198845, 38361.42457863134, 38855.80572097121, 38880.0, 38913.0, 38925.41611875824, 3194.105650417887, 3282.5404443377947, 3295.703386695185, 3374.8650053997812, 3622.5109610202812, 28740.42519149605, 29111.12666620005, 29212.853935730185, 29907.401851963055, 30073.398532029456, 3223.564818749462, 3260.2175477885376, 3267.6405595384726, 3320.0537846713814, 3420.521127042216, 235724.0, 236382.0, 237488.0, 237546.99999999828, 238570.0, 48826.51173488291, 53416.0, 54516.72741636346, 54528.27453117366, 54650.72674636601, 59155.70422147862, 59628.403715963155, 59902.40097599055, 59962.70018649879, 59977.0, 14279.500217492337, 14533.273336333352, 14539.0, 14541.345639446039, 14557.708845823025, 10228.948855255825, 10902.0, 11045.39250341239, 11046.447677616086, 11140.61007864737, 18194.636107278046, 18282.90858545699, 18332.816671833378, 18426.078696065142, 18598.81401185998, 7137.286271372925, 7246.311600398059, 7292.270772922771, 7332.560046397233, 7363.8159046024275, 899.5906862377602, 912.7900582865979, 915.9862602060974, 919.2691810011057, 926.8795056642593, 26808.195754127406, 26956.050134591456, 27353.86323068372, 27540.862295688796, 27788.0, 970.9708708738749, 1009.4145395670494, 1017.0541396501177, 1062.5484169228203, 1092.5738961804902, 13799.86200138006, 14401.855981440262, 14501.03046706234, 14550.563483095524, 14636.0, 270305.0, 273073.0, 273814.0, 274117.0, 274793.0, 46045.53954460412, 46613.766931165126, 46638.0, 46820.0, 47016.294755578696, 1200.8924337787128, 1224.253205544617, 1236.5857437758273, 1247.0335489995146, 1249.9500019999098, 26236.8688156558, 26660.8666956664, 26747.19758407251, 27506.312342191606, 27527.31181720473, 41085.58914410818, 41355.58644413517, 41411.585884141976, 41504.58495415007, 41527.0, 252535.0, 253317.0, 253418.0, 253503.0, 254049.0, 26902.461950760484, 30485.69514304917, 30967.380652386375, 31492.370152596362, 31580.526292106097, 35231.47152792761, 35567.46648800218, 35775.46336804898, 35847.0, 36093.819530902176, 30263.243418914702, 30532.847335763177, 32635.18412039718, 32822.835885820416, 32972.0, 32648.673513264563, 32700.50949235716, 32851.178720532174, 33010.504842426904, 33348.1662958428, 32345.51481727729, 32776.0, 33009.50485742668, 33152.17119571933, 33203.0, 29459.263518412212, 29542.40915181727, 30004.0, 30014.24964375821, 30064.84967575148, 23436.0, 23582.52834943257, 23865.8067096641, 23957.640635390133, 23990.920408581307], "unit": "score", "name": "ext.html", "value": 16944.41040489374}, {"lowerIsBetter": false, "replicates": [337.67245771601546, 337.9273456206915, 343.9518467414562, 345.99999999999994, 347.6141482953922, 14714.411423543059, 15282.159481228528, 15895.761563576541, 16506.752398713998, 16659.50021499354, 10262.948685256562, 10654.893451065487, 10660.093892019167, 16136.83863161368, 16509.752353714703, 4478.820847166109, 4606.170889239936, 4613.238815595423, 4624.09830083134, 4631.814727410916, 4421.336799480087, 4534.274516077428, 4580.244259697146, 4583.679142460029, 4625.144348295559, 4498.437695288089, 4527.864164075083, 4534.863954081383, 4535.614472769818, 4548.977255113737, 4565.589096981287, 4569.954300457002, 4572.771361431932, 4573.794179261941, 4575.542445755431, 4872.293517439952, 5058.570021548173, 5073.365829271341, 5074.035933172685, 5074.340335756365, 19095.14071866769, 19241.51896202606, 19668.606627867506, 19887.602247955103, 19896.20415183391, 1808.5569035586234, 1939.8933058681907, 1940.3208876892975, 2042.1627132875449, 2308.5382923415386, 9458.716238512856, 9466.432014079177, 11434.183892229272, 12303.507859685602, 12720.236785792882, 1750.6061136244243, 1753.8684598655152, 1758.0594382005565, 1777.79555351135, 1803.846673032794, 57658.0, 57796.13305800416, 58781.0, 60567.69716151435, 60673.0, 9349.53252337394, 9459.858102128474, 9632.181264592447, 9657.32398732096, 9669.516524173763, 12631.494740210472, 12687.492500299884, 12760.680982975315, 12800.0, 12833.0, 6882.793516194522, 7026.859462810715, 7072.681729322193, 7086.149662040588, 7135.750248741373, 6753.1220941277315, 6779.2881747416795, 6817.147856517935, 6830.8633827324165, 6887.862242755117, 4244.639205667491, 4302.870913872589, 4311.267084595626, 4337.414449049401, 4370.431843860278, 1728.2914005257785, 1783.9464816055538, 1818.9909050454662, 1823.5896923192176, 1833.120102350879, 830.4270053662954, 860.2214995429147, 864.6584599083452, 917.8645478547515, 923.3213588012806, 15568.844311556739, 15817.841821581636, 16128.112953787655, 16280.185990700418, 16481.505554833373, 824.6454024769407, 839.6221700234919, 842.3429724814654, 851.0765819086237, 857.9571021448903, 8427.115152908857, 9328.906710932804, 9932.702018939442, 9946.701598952042, 10103.797924041479, 375712.0, 383014.0, 394761.0, 395228.0, 398358.0738866758, 71033.0, 71580.0, 72336.27663723295, 72389.0, 73434.26565734381, 960.7886265021684, 969.5443141723379, 987.9231637515143, 988.0613417253494, 1006.9144122749502, 14909.850901490847, 15204.315805788987, 15265.23673816327, 15376.538703838904, 15389.153596552296, 32810.50784238191, 34808.47787283243, 34828.12929676778, 35582.0, 36286.818565907, 46693.53306467028, 48914.0, 48968.51031489782, 49002.0, 49540.25689614731, 7528.811779705332, 7644.273793989562, 7684.731034413769, 7703.229677032252, 7764.92235077642, 10649.307794993301, 11019.779604408028, 11087.946645068705, 11565.421728913689, 11573.826392603949, 10244.334118282586, 10367.585296588051, 10380.169586432916, 10476.266661333633, 10539.841902371318, 9596.280278978966, 10176.847347289648, 10240.64157754475, 10343.0, 10392.688219353431, 10252.513385558903, 10461.581536738446, 10504.159667226757, 10768.676939691823, 10797.514111865143, 7492.887606686013, 7535.660895259617, 7544.0569928758905, 7570.205128461653, 7596.164421913474, 10434.530446130095, 10475.371477711362, 10529.842052369067, 10629.89370106289, 10691.679249622524], "unit": "score", "name": "jquery.html", "value": 7885.663532045436}, {"lowerIsBetter": false, "replicates": [1315.4212146655477, 1386.4869998100703, 1412.6821465170335, 1553.5339398180543, 1785.1431312969767, 7044.823879403018, 7283.562986220823, 7314.926850731497, 7323.231060738625, 7333.339999400053, 7084.822879428017, 7201.927980720191, 7206.351428371446, 7209.423246140309, 7215.711371545131, 1907.761529808774, 1944.8541359398102, 2178.6187417202004, 2216.8891555422247, 2242.7420846602604, 2245.595792757303, 2247.2696373678536, 2251.5722012817596, 2252.222983070846, 2252.324302709189, 2155.353393981807, 2188.5294661647745, 2199.0324257326806, 2232.5646498932715, 2234.1175235781857, 2157.1155826111376, 2157.9352619421443, 2159.2442645074257, 2161.7405911290666, 2164.285785690718, 2095.0153427888868, 2125.2774056820754, 2125.7130287411155, 2127.702121702963, 2130.403487023636, 7479.5886226257535, 7546.434017448659, 7546.434017448713, 7553.773386798405, 7563.205863384321, 4591.655625828076, 4671.766411679437, 4684.836030738942, 4712.552307530779, 4715.693479923828, 2816.464871674396, 3012.969870301291, 3018.0945716285028, 3023.5313526403443, 3041.300500884809, 898.8606765951288, 922.8800255966681, 931.855562387831, 934.7709811096257, 953.6566835939057, 10158.949205253926, 10188.337758045704, 10190.89809101907, 10203.234757393226, 10213.948930255301, 4124.4019617155345, 4191.685623578243, 4233.576642335742, 4261.403403523509, 4266.701330906807, 8696.869546956801, 8732.738017859474, 8753.562321883881, 8756.51839148853, 8760.386772925835, 4710.24636058229, 4710.6702530823195, 4723.622110231173, 4726.149293127201, 4728.0780247851335, 3746.138388170736, 3965.643092121723, 4089.1208390195657, 4104.8768536943935, 4255.702100852973, 3514.7539672222697, 3565.2691198304287, 3590.6947909427467, 3593.7843729376323, 3606.3508568457405, 1153.7231064544617, 1166.2827361172817, 1168.526746667601, 1177.3583397048628, 1187.5240124340846, 980.4558470049191, 990.2968892086699, 994.264244459095, 996.5764550066193, 1042.8748550173875, 7016.859662806715, 7019.4384449243935, 7024.4029257513685, 7086.893696594555, 7088.92911070893, 455.62866263995403, 456.22441848857073, 456.76020089453306, 457.93131030345717, 468.5759387754088, 5306.495882891119, 5309.495597918191, 5313.0967735485065, 5323.893522129613, 5352.705601191894, 8471.576421178916, 8671.436356636925, 8697.652093916298, 8698.95650521756, 8705.260052895448, 8654.35092368075, 8676.739697809076, 8697.95651021741, 8698.0, 8698.91301086981, 6730.0, 7049.189343225492, 7054.823629409203, 7093.042439270633, 7120.359167674934, 6931.445484361138, 6962.060121883684, 6986.720531178696, 6990.580565166107, 7160.534565253241, 7967.402444816546, 8071.394645401736, 8186.3860210485645, 8210.712625058095, 8327.292180164754, 8415.0, 8418.410711250153, 8481.06708262103, 8506.191911768372, 8572.485650860968, 5794.101914203306, 6217.564770466024, 6269.780557680641, 6395.712192951235, 6446.129772480655, 7030.3321184487395, 7052.788416347517, 7071.752488662872, 7091.468139889632, 7114.253003434772, 6266.624002559861, 6324.905126423199, 6335.90496142549, 6495.935040649722, 6566.671666416564, 6354.52341074412, 6356.141920840627, 6405.807825765234, 6470.708818103102, 6560.081588577507, 6760.695768690519, 6788.456923446014, 6811.795646130624, 6813.8977915330315, 6830.556013859084, 6092.360302168208, 6105.481034111973, 6167.660778657217, 6259.906101408574, 6272.655003974825, 6349.619022858643, 6353.555251132377, 6388.840278993062, 6413.807585772434, 6423.646699431576], "unit": "score", "name": "mootools.html", "value": 4180.587045379588}, {"lowerIsBetter": false, "replicates": [312.8107494965546, 313.20602273237347, 314.3194982862104, 317.75691595929106, 320.31612507296916, 5288.894222115556, 5349.652272602283, 5362.758675859586, 5425.13197888338, 5425.186222066692, 5292.894142117165, 5308.495692909168, 5312.07038768216, 5316.49493298137, 5324.094903866342, 3920.705947053968, 4013.076992291775, 4160.022394737234, 4170.72890262132, 4173.56177601352, 4167.0, 4168.62482376586, 4170.728902621335, 4171.937420938689, 4172.77049762263, 4130.896727581804, 4139.461869956901, 4142.420061191436, 4142.606452387018, 4144.6684265258855, 3928.960710392888, 4047.5345335286524, 4133.81397837095, 4145.97927010366, 4147.108371700099, 3633.5276414066266, 3649.1424515238896, 3651.8174091295327, 3654.3604869148057, 3656.8537258509627, 5142.897142057175, 5148.3564554430695, 5153.5361817436615, 5157.149070403379, 5161.81933632321, 4788.497207793202, 4802.207635740098, 4803.519648035203, 4806.303086052538, 4807.975960120212, 5646.632968857011, 5649.745761440745, 5654.858628534278, 5655.604107712462, 5659.688717120557, 4012.8996775080564, 4016.176683779818, 4018.9196216075516, 4021.336479480882, 4022.879313620596, 5734.483896449339, 5849.707514624251, 5920.437558431942, 5924.081767326072, 5925.674087925162, 4107.158032603309, 4117.814698338582, 4129.359949207877, 4130.731502452331, 4137.193247316744, 4165.083681590046, 4170.35359519275, 4176.7076304658385, 4187.413762073312, 4190.099128687347, 4750.501197374226, 4755.0, 4757.072370887644, 4757.072370887644, 4765.0, 5615.382307946123, 5616.241807356037, 5619.409961953936, 5621.522170615462, 5622.718864056781, 1449.8985071045136, 1477.18754684925, 1479.0090639271714, 1479.2381923309504, 1482.7256957462903, 887.9822403551893, 925.287528602972, 946.0586716217271, 955.0, 991.7471044883508, 4820.68665536739, 4907.7300748458465, 4931.90136197274, 4933.136701077369, 4936.6297527685565, 5791.88416231673, 5810.767569297265, 5823.30120385548, 5824.0390335595, 5824.388439213906, 4911.435184953704, 4918.213085906309, 4920.3603531541385, 4927.827526036572, 4929.679570827885, 3109.0983614751467, 3151.6218053833686, 3156.337169194495, 3156.952645710316, 3157.984210078981, 5521.69630670317, 5526.47498487643, 5527.032769265443, 5527.364353099445, 5533.335999680065, 5827.388124246893, 5972.283326000907, 5988.550858685616, 6001.2498437695285, 6009.1587177795145, 5481.616286859961, 5504.559635229172, 5514.834554963438, 5519.282493275929, 5523.199136125159, 5868.706564671835, 5874.353821079763, 5874.794382196774, 5879.559033072622, 5933.821985340447, 5729.627574207663, 5731.168980497888, 5739.598228123991, 5746.626469279484, 5750.424957504216, 5358.437364076716, 5503.11950087984, 5504.587155963239, 5506.807261745819, 5511.53151982086, 3995.2808494471274, 4000.9199816002933, 4003.939940900947, 4005.2790497709525, 4007.479027726377, 5792.507636850746, 5828.388019257917, 5846.94153058464, 5854.092615644582, 5892.793752218652, 5643.830685079454, 5650.350209725934, 5652.745626446737, 5652.7738890443925, 5657.066584013592, 5600.691961942132, 5649.0, 5655.3213614364895, 5659.886802264014, 5663.782286808356, 5342.519173274424, 5567.777288908398, 5580.330360356783, 5590.440955904377, 5591.440855914539, 5632.774689012557, 5652.434756524479, 5656.575756818337, 5657.886842263214, 5663.858403539944, 5522.806701765419, 5529.087700529529, 5536.612437129363, 5585.888282234414, 5590.692511911721], "unit": "score", "name": "prototype.html", "value": 4239.992083362523}, {"lowerIsBetter": false, "replicates": [761.4707778094224, 761.8209720715635, 773.3619763694946, 779.7855589712829, 796.6494742313382, 14035.78946315806, 14276.0, 14292.571222863318, 14298.714025719506, 14303.928480357583, 13507.459701611924, 13755.587332380019, 13764.242966636832, 13854.653633659163, 13861.099028563136, 651.4039653716843, 801.4910531812312, 812.5733989655419, 845.7674139611595, 847.9491230526188, 792.0455850699922, 826.5454000299811, 834.7454026521908, 838.4256784102879, 838.6435764799966, 826.3430572694692, 864.6584599083359, 873.2097451806094, 873.4235404632943, 873.4322690251356, 675.9155105611799, 838.0655569040537, 867.9999999999968, 869.217704066339, 869.3697069624535, 600.3246347858659, 611.6972098811073, 633.882731694638, 634.5431289471574, 634.5716641267172, 11894.52421903123, 11910.642680719593, 11972.461239244254, 11998.0, 12025.158238923279, 11674.241174323726, 12135.575254866126, 12165.51337946481, 12206.755864882653, 12484.687882802911, 9909.75225619358, 9916.851247231225, 9922.851157232648, 10038.749031274203, 10068.043535864155, 3239.757018223619, 3256.3161736035463, 3317.834108294576, 3340.43212653847, 3375.206826395795, 44281.77859110748, 45168.3224751629, 45231.321530177076, 45760.54239457596, 45790.54209457896, 9492.050794920453, 9643.758906027266, 9664.08191221847, 9894.55474503649, 9931.900680993242, 16781.328746850235, 16814.411495597597, 16816.915915420344, 16839.07385093807, 16839.326426942785, 6548.738050477928, 6560.540762146699, 6632.403083722488, 6653.900191497131, 6761.729530818712, 3530.0998245447245, 3554.0759402555004, 3702.33357995558, 3711.9072023199637, 3716.4611131385795, 2646.8147229694123, 2668.8932442702076, 2670.5593577059567, 2673.31830383251, 2674.665666791651, 479.549223729693, 481.58343033275963, 490.43109992408637, 490.94108706955393, 523.1551045062197, 544.4881811097634, 597.5249676507187, 619.5479777953987, 634.4860662863096, 640.5036097024843, 7100.325469080429, 7294.161171465349, 7392.075990501187, 7425.0, 7525.9386243807985, 551.6910530103155, 554.4344768336274, 555.4279092534696, 559.3427722426133, 566.0744682444233, 3413.906414952238, 3475.374432602156, 3507.2810073934784, 3539.9292014159573, 3543.0, 51898.740506297225, 52451.47548524542, 52766.73616631892, 52874.206886896725, 52925.735371323666, 45774.0, 46131.0, 46183.0, 47470.5252947473, 47788.5221147791, 41788.37317440241, 42616.78691606522, 42792.0, 43335.13329733388, 43556.78221608935, 7003.264657211123, 7036.472264580075, 7051.435885129074, 7081.185663648746, 7178.928210717826, 32153.196170095936, 32977.175570610925, 33011.44669975042, 33208.833955830065, 33414.66585334213, 38291.808540958235, 38720.80639596784, 38744.2251154981, 41394.0, 41490.58509414867, 8634.136586341316, 8801.779955501164, 8809.911900881165, 8904.777380565538, 9049.864252036356, 8661.657443096077, 9150.588223529823, 9218.308626853148, 9385.812283754423, 11404.657860264206, 10178.949105254427, 10199.38803671782, 10255.128314093387, 10348.586056557653, 10836.187285953427, 10347.896521034994, 10563.894361056291, 10817.729556761144, 10932.125429965743, 11168.553257869595, 10770.784584308427, 10909.39998300101, 10977.945110274397, 11205.887941120485, 11350.432478375884, 9098.727038188865, 9234.076592340982, 9260.39807412516, 9794.75513112178, 9852.310338276251, 9223.308251881002, 9344.95327523358, 9362.625494980124, 9543.42739435636, 9554.474503902075], "unit": "score", "name": "yui.html", "value": 5840.350479378771}], "name": "dromaeo_css", "value": 6322.809839737756}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 112.0, 113.0, 113.0, 102.0, 113.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [159.0, 136.0, 155.0, 187.0, 131.0, 159.0, 151.0, 133.0, 184.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 153.3}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 161.0, 161.0, 161.0, 160.0, 161.0, 165.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 108.0, 104.0, 74.0, 74.0, 73.0, 112.0, 99.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.8}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 139.0, 93.0, 93.0, 94.0, 135.0, 94.0, 95.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 116.0, 118.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 67.0, 66.0, 67.0, 67.0, 66.0, 74.0, 63.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 66.3}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 62.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 92.0, 84.0, 83.0, 86.0, 92.0, 83.0, 86.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [124.0, 124.0, 118.0, 116.0, 126.0, 120.0, 127.0, 119.0, 128.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [146.0, 131.0, 142.0, 142.0, 144.0, 143.0, 141.0, 141.0, 149.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.4}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 68.0, 69.0, 66.0, 69.0, 69.0, 69.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1527.5}]} 05:35:09 INFO - Return code: 0 05:35:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:35:09 ERROR - # TBPL SUCCESS # 05:35:09 INFO - Running post-action listener: _resource_record_post_action 05:35:09 INFO - Running post-run listener: _resource_record_post_run 05:35:10 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 433741824; Read time: 0; Write time: 315612 05:35:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109744128; Read time: 0; Write time: 79528 05:35:10 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289607680; Read time: 0; Write time: 184976 05:35:10 INFO - Running post-run listener: _upload_blobber_files 05:35:10 INFO - Blob upload gear active. 05:35:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:35:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:35:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:35:11 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:35:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:35:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:12 INFO - (blobuploader) - INFO - Done attempting. 05:35:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:35:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:35:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:13 INFO - (blobuploader) - INFO - Done attempting. 05:35:13 INFO - (blobuploader) - INFO - Iteration through files over. 05:35:13 INFO - Return code: 0 05:35:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:35:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:35:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05f93ce9d221036c2799c229f1a3e11164a53e460579147a50a17edf40246c9cb3757ba11a79b0ea9c4f6a14d9e814f34e21a95a6d8e1d9edebdbe560ebed8e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdea7e708d39a3b9a750178fddc6923772f872a944d3cd598bb37e3aae03fa7a71bfeda5129629d47fb1d3462976b0ceef21947988e128903c730755c7e725ce"} 05:35:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:35:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:35:13 INFO - Contents: 05:35:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05f93ce9d221036c2799c229f1a3e11164a53e460579147a50a17edf40246c9cb3757ba11a79b0ea9c4f6a14d9e814f34e21a95a6d8e1d9edebdbe560ebed8e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdea7e708d39a3b9a750178fddc6923772f872a944d3cd598bb37e3aae03fa7a71bfeda5129629d47fb1d3462976b0ceef21947988e128903c730755c7e725ce"} 05:35:13 INFO - Running post-run listener: copy_logs_to_upload_dir 05:35:13 INFO - Copying logs to upload dir... 05:35:13 INFO - mkdir: /builds/slave/test/build/upload/logs 05:35:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.819422 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-06 05:35:10.611802) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 05:35:10.615650) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05f93ce9d221036c2799c229f1a3e11164a53e460579147a50a17edf40246c9cb3757ba11a79b0ea9c4f6a14d9e814f34e21a95a6d8e1d9edebdbe560ebed8e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdea7e708d39a3b9a750178fddc6923772f872a944d3cd598bb37e3aae03fa7a71bfeda5129629d47fb1d3462976b0ceef21947988e128903c730755c7e725ce"} build_url:https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/Rbr9RCsJRGu4qvIXl_vLTw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05f93ce9d221036c2799c229f1a3e11164a53e460579147a50a17edf40246c9cb3757ba11a79b0ea9c4f6a14d9e814f34e21a95a6d8e1d9edebdbe560ebed8e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdea7e708d39a3b9a750178fddc6923772f872a944d3cd598bb37e3aae03fa7a71bfeda5129629d47fb1d3462976b0ceef21947988e128903c730755c7e725ce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 05:35:10.639860) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 05:35:10.640173) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1459943871.3973-513657945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 05:35:10.730421) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 05:35:10.730736) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 05:35:10.731084) ========= ========= Total master_lag: 0.26 =========