builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-044 starttime: 1458155968.46 results: success (0) buildid: 20160316113845 builduid: 32d7641c91e94541bb36bf0fe397a2e0 revision: 4116cafbb87dd251990450f8f90911beecbe0859 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.462575) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.463031) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.463324) ========= 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=574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004924 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.484924) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.485237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.498238) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.498675) ========= 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=574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.548723) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.549014) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.549393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.549729) ========= 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=574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-16 12:19:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.2M=0s 2016-03-16 12:19:30 (83.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108440 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.671640) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.671980) ========= 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=574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022417 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.722281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:28.722658) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4116cafbb87dd251990450f8f90911beecbe0859 --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 4116cafbb87dd251990450f8f90911beecbe0859 --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=574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-16 12:19:30,253 truncating revision to first 12 chars 2016-03-16 12:19:30,253 Setting DEBUG logging. 2016-03-16 12:19:30,253 attempt 1/10 2016-03-16 12:19:30,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4116cafbb87d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 12:19:30,827 unpacking tar archive at: fx-team-4116cafbb87d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.855447 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:29.591432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:29.591805) ========= echo 4116cafbb87dd251990450f8f90911beecbe0859 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4116cafbb87dd251990450f8f90911beecbe0859'] 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=574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4116cafbb87dd251990450f8f90911beecbe0859 program finished with exit code 0 elapsedTime=0.003571 script_repo_revision: '4116cafbb87dd251990450f8f90911beecbe0859' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:29.641515) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:29.641844) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 12:19:29.652396) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-16 12:19:29.652740) ========= /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=574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:19:31 INFO - MultiFileLogger online at 20160316 12:19:31 in /builds/slave/test 12:19:31 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 12:19:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:19:31 INFO - {'append_to_log': False, 12:19:31 INFO - 'base_work_dir': '/builds/slave/test', 12:19:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:19:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:19:31 INFO - 'branch': 'Fx-Team-Non-PGO', 12:19:31 INFO - 'buildbot_json_path': 'buildprops.json', 12:19:31 INFO - 'config_files': ('talos/linux_config.py',), 12:19:31 INFO - 'default_actions': ('clobber', 12:19:31 INFO - 'read-buildbot-config', 12:19:31 INFO - 'download-and-extract', 12:19:31 INFO - 'populate-webroot', 12:19:31 INFO - 'create-virtualenv', 12:19:31 INFO - 'install', 12:19:31 INFO - 'run-tests'), 12:19:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:19:31 INFO - 'download_minidump_stackwalk': True, 12:19:31 INFO - 'download_symbols': 'ondemand', 12:19:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:19:31 INFO - 'tooltool.py': '/tools/tooltool.py', 12:19:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:19:31 INFO - '/tools/misc-python/virtualenv.py')}, 12:19:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:19:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:19:31 INFO - 'installer_path': 'installer.exe', 12:19:31 INFO - 'log_level': 'info', 12:19:31 INFO - 'log_name': 'talos', 12:19:31 INFO - 'log_to_console': True, 12:19:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:19:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:19:31 INFO - 'opt_config_files': (), 12:19:31 INFO - 'pip_index': False, 12:19:31 INFO - 'sps_profile': False, 12:19:31 INFO - 'sps_profile_interval': 0, 12:19:31 INFO - 'suite': 'dromaeojs', 12:19:31 INFO - 'system_bits': '32', 12:19:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:19:31 INFO - 'title': 'talos-linux64-ix-044', 12:19:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:19:31 INFO - 'use_talos_json': True, 12:19:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:19:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:19:31 INFO - 'work_dir': 'build'} 12:19:31 INFO - ##### 12:19:31 INFO - ##### Running clobber step. 12:19:31 INFO - ##### 12:19:31 INFO - Running pre-action listener: _resource_record_pre_action 12:19:31 INFO - Running main action method: clobber 12:19:31 INFO - rmtree: /builds/slave/test/build 12:19:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:19:32 INFO - Running post-action listener: _resource_record_post_action 12:19:32 INFO - ##### 12:19:32 INFO - ##### Running read-buildbot-config step. 12:19:32 INFO - ##### 12:19:32 INFO - Running pre-action listener: _resource_record_pre_action 12:19:32 INFO - Running main action method: read_buildbot_config 12:19:32 INFO - Using buildbot properties: 12:19:32 INFO - { 12:19:32 INFO - "project": "", 12:19:32 INFO - "product": "firefox", 12:19:32 INFO - "script_repo_revision": "production", 12:19:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:19:32 INFO - "repository": "", 12:19:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:19:32 INFO - "buildid": "20160316113845", 12:19:32 INFO - "pgo_build": "False", 12:19:32 INFO - "basedir": "/builds/slave/test", 12:19:32 INFO - "buildnumber": 2650, 12:19:32 INFO - "slavename": "talos-linux64-ix-044", 12:19:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:19:32 INFO - "platform": "ubuntu64_hw", 12:19:32 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:19:32 INFO - "branch": "fx-team", 12:19:32 INFO - "repo_path": "integration/fx-team", 12:19:32 INFO - "revision": "4116cafbb87dd251990450f8f90911beecbe0859", 12:19:32 INFO - "stage_platform": "linux64", 12:19:32 INFO - "builduid": "32d7641c91e94541bb36bf0fe397a2e0", 12:19:32 INFO - "slavebuilddir": "test" 12:19:32 INFO - } 12:19:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:19:32 INFO - Running post-action listener: _resource_record_post_action 12:19:32 INFO - ##### 12:19:32 INFO - ##### Running download-and-extract step. 12:19:32 INFO - ##### 12:19:32 INFO - Running pre-action listener: _resource_record_pre_action 12:19:32 INFO - Running main action method: download_and_extract 12:19:32 INFO - mkdir: /builds/slave/test/build/tests 12:19: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')]} 12:19:32 INFO - https://queue.taskcluster.net/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:19:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:19:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:19:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/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 12:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/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 12:19:32 INFO - Downloaded 1361 bytes. 12:19:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:19:32 INFO - Using the following test package requirements: 12:19:32 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:19:32 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:19:32 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:19:32 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:32 INFO - u'jsshell-linux-x86_64.zip'], 12:19:32 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:19:32 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:19:32 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:19:32 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:19:32 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:19:32 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:19:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:19:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:19: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')]} 12:19:32 INFO - https://queue.taskcluster.net/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:19:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/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 12:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/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 12:19:33 INFO - Downloaded 21992926 bytes. 12:19:33 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'] 12:19:33 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 12:19:35 INFO - Return code: 0 12:19:35 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 12:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:35 INFO - https://queue.taskcluster.net/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:19:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:19:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/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 12:19:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/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 12:19:36 INFO - Downloaded 21992926 bytes. 12:19:36 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'] 12:19:36 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 12:19:37 INFO - Return code: 0 12:19: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')]} 12:19:37 INFO - https://queue.taskcluster.net/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:19:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:19:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:19:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/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 12:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/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 12:19:38 INFO - Downloaded 10846462 bytes. 12:19:38 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'] 12:19:38 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 12:19:39 INFO - Return code: 0 12:19: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')]} 12:19:39 INFO - https://queue.taskcluster.net/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:19:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:19:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:19:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/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 12:19:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPI7kt6WSK2UVaWF9BlhqA/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 12:19:40 INFO - Downloaded 54143344 bytes. 12:19:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:19:40 INFO - mkdir: /builds/slave/test/properties 12:19:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:19:40 INFO - Writing to file /builds/slave/test/properties/build_url 12:19:40 INFO - Contents: 12:19:40 INFO - build_url:https://queue.taskcluster.net/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:19:41 INFO - Running post-action listener: _resource_record_post_action 12:19:41 INFO - Running post-action listener: set_extra_try_arguments 12:19:41 INFO - ##### 12:19:41 INFO - ##### Running populate-webroot step. 12:19:41 INFO - ##### 12:19:41 INFO - Running pre-action listener: _resource_record_pre_action 12:19:41 INFO - Running main action method: populate_webroot 12:19:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:19:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:19:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:19:41 INFO - '--tppagecycles', 12:19:41 INFO - '7'], 12:19:41 INFO - 'tests': ['tsvgm']}}, 12:19:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:19:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:19:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:19:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:19:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:19:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:19:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:41 INFO - 'talos_options': ['--e10s'], 12:19:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:41 INFO - 'tests': ['damp', 'tps']}, 12:19:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:41 INFO - 'talos_options': ['--e10s'], 12:19:41 INFO - 'tests': ['damp', 'tps']}, 12:19:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:19:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:19:41 INFO - 'other': {'tests': ['a11yr', 12:19:41 INFO - 'ts_paint', 12:19:41 INFO - 'tpaint', 12:19:41 INFO - 'sessionrestore', 12:19:41 INFO - 'sessionrestore_no_auto_restore', 12:19:41 INFO - 'tabpaint']}, 12:19:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:19:41 INFO - 'tests': ['a11yr', 12:19:41 INFO - 'ts_paint', 12:19:41 INFO - 'tpaint', 12:19:41 INFO - 'sessionrestore', 12:19:41 INFO - 'sessionrestore_no_auto_restore', 12:19:41 INFO - 'tabpaint']}, 12:19:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:19:41 INFO - 'tests': ['a11yr', 12:19:41 INFO - 'ts_paint', 12:19:41 INFO - 'tpaint', 12:19:41 INFO - 'sessionrestore', 12:19:41 INFO - 'sessionrestore_no_auto_restore', 12:19:41 INFO - 'tabpaint']}, 12:19:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:19:41 INFO - 'tests': ['a11yr', 12:19:41 INFO - 'ts_paint', 12:19:41 INFO - 'tpaint', 12:19:41 INFO - 'sessionrestore', 12:19:41 INFO - 'sessionrestore_no_auto_restore', 12:19:41 INFO - 'tabpaint']}, 12:19:41 INFO - 'other_l64': {'tests': ['a11yr', 12:19:41 INFO - 'ts_paint', 12:19:41 INFO - 'tpaint', 12:19:41 INFO - 'sessionrestore', 12:19:41 INFO - 'sessionrestore_no_auto_restore', 12:19:41 INFO - 'tabpaint']}, 12:19:41 INFO - 'other_nol64': {'tests': ['a11yr', 12:19:41 INFO - 'ts_paint', 12:19:41 INFO - 'tpaint', 12:19:41 INFO - 'sessionrestore', 12:19:41 INFO - 'sessionrestore_no_auto_restore', 12:19:41 INFO - 'tabpaint']}, 12:19:41 INFO - 'svgr': {'tests': ['tsvgx', 12:19:41 INFO - 'tsvgr_opacity', 12:19:41 INFO - 'tart', 12:19:41 INFO - 'tscrollx', 12:19:41 INFO - 'cart']}, 12:19:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:19:41 INFO - 'tests': ['tsvgx', 12:19:41 INFO - 'tsvgr_opacity', 12:19:41 INFO - 'tart', 12:19:41 INFO - 'tscrollx', 12:19:41 INFO - 'cart']}, 12:19:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:41 INFO - 'tests': ['tp5o']}, 12:19:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:41 INFO - 'talos_options': ['--e10s'], 12:19:41 INFO - 'tests': ['tp5o']}, 12:19:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:41 INFO - 'talos_options': ['--xperf_path', 12:19:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:41 INFO - 'tests': ['tp5n']}, 12:19:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:41 INFO - 'talos_options': ['--e10s', 12:19:41 INFO - '--xperf_path', 12:19:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:41 INFO - 'tests': ['tp5n']}}, 12:19:41 INFO - 'talos.zip': {'path': '', 12:19:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:19:41 INFO - Running post-action listener: _resource_record_post_action 12:19:41 INFO - ##### 12:19:41 INFO - ##### Running create-virtualenv step. 12:19:41 INFO - ##### 12:19:41 INFO - Running pre-action listener: _resource_record_pre_action 12:19:41 INFO - Running main action method: create_virtualenv 12:19:41 INFO - Creating virtualenv /builds/slave/test/build/venv 12:19:41 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 12:19:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:19:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:19:41 INFO - Using real prefix '/usr' 12:19:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:19:41 INFO - Installing distribute.............................................................................................................................................................................................done. 12:19:43 INFO - Installing pip.................done. 12:19:43 INFO - Return code: 0 12:19:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:43 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 0x7fa32432af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e4160>, '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 0x26e5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e54f0>, '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': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', '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 12:19:43 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 12:19:43 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 12:19:43 INFO - Using env: {'DISPLAY': ':0', 12:19:43 INFO - 'HOME': '/home/cltbld', 12:19:43 INFO - 'LANG': 'en_US.UTF-8', 12:19:43 INFO - 'LANGUAGE': 'en_US:en', 12:19:43 INFO - 'LOGNAME': 'cltbld', 12:19:43 INFO - 'MAIL': '/var/mail/cltbld', 12:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:43 INFO - 'MOZ_NO_REMOTE': '1', 12:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:43 INFO - 'NO_EM_RESTART': '1', 12:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:43 INFO - 'PWD': '/builds/slave/test', 12:19:43 INFO - 'SHELL': '/bin/bash', 12:19:43 INFO - 'SHLVL': '1', 12:19:43 INFO - 'TERM': 'linux', 12:19:43 INFO - 'TMOUT': '86400', 12:19:43 INFO - 'USER': 'cltbld', 12:19:43 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', 12:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:43 INFO - '_': '/tools/buildbot/bin/python'} 12:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:44 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 12:19:44 INFO - Cleaning up... 12:19:44 INFO - Return code: 0 12:19:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:44 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 0x7fa32432af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e4160>, '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 0x26e5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e54f0>, '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': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', '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 12:19:44 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 12:19:44 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 12:19:44 INFO - Using env: {'DISPLAY': ':0', 12:19:44 INFO - 'HOME': '/home/cltbld', 12:19:44 INFO - 'LANG': 'en_US.UTF-8', 12:19:44 INFO - 'LANGUAGE': 'en_US:en', 12:19:44 INFO - 'LOGNAME': 'cltbld', 12:19:44 INFO - 'MAIL': '/var/mail/cltbld', 12:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:44 INFO - 'MOZ_NO_REMOTE': '1', 12:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:44 INFO - 'NO_EM_RESTART': '1', 12:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:44 INFO - 'PWD': '/builds/slave/test', 12:19:44 INFO - 'SHELL': '/bin/bash', 12:19:44 INFO - 'SHLVL': '1', 12:19:44 INFO - 'TERM': 'linux', 12:19:44 INFO - 'TMOUT': '86400', 12:19:44 INFO - 'USER': 'cltbld', 12:19:44 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', 12:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:44 INFO - '_': '/tools/buildbot/bin/python'} 12:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:44 INFO - Downloading/unpacking psutil>=0.7.1 12:19:44 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 12:19:44 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 12:19:44 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 12:19:44 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 12:19:44 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 12:19:44 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 12:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:19:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:46 INFO - Installing collected packages: psutil 12:19:46 INFO - Running setup.py install for psutil 12:19:46 INFO - building 'psutil._psutil_linux' extension 12:19:46 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 12:19:46 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 12:19:46 INFO - building 'psutil._psutil_posix' extension 12:19:46 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 12:19:46 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 12:19:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:46 INFO - Successfully installed psutil 12:19:46 INFO - Cleaning up... 12:19:46 INFO - Return code: 0 12:19:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:46 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 0x7fa32432af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e4160>, '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 0x26e5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e54f0>, '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': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', '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 12:19:46 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 12:19:46 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 12:19:46 INFO - Using env: {'DISPLAY': ':0', 12:19:46 INFO - 'HOME': '/home/cltbld', 12:19:46 INFO - 'LANG': 'en_US.UTF-8', 12:19:46 INFO - 'LANGUAGE': 'en_US:en', 12:19:46 INFO - 'LOGNAME': 'cltbld', 12:19:46 INFO - 'MAIL': '/var/mail/cltbld', 12:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:46 INFO - 'MOZ_NO_REMOTE': '1', 12:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:46 INFO - 'NO_EM_RESTART': '1', 12:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:46 INFO - 'PWD': '/builds/slave/test', 12:19:46 INFO - 'SHELL': '/bin/bash', 12:19:46 INFO - 'SHLVL': '1', 12:19:46 INFO - 'TERM': 'linux', 12:19:46 INFO - 'TMOUT': '86400', 12:19:46 INFO - 'USER': 'cltbld', 12:19:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', 12:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:46 INFO - '_': '/tools/buildbot/bin/python'} 12:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:19:47 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 12:19:47 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 12:19:47 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 12:19:47 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 12:19:47 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 12:19:47 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 12:19:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:19:48 INFO - Installing collected packages: mozsystemmonitor 12:19:48 INFO - Running setup.py install for mozsystemmonitor 12:19:49 INFO - Successfully installed mozsystemmonitor 12:19:49 INFO - Cleaning up... 12:19:49 INFO - Return code: 0 12:19:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:49 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 0x7fa32432af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e4160>, '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 0x26e5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e54f0>, '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': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', '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 12:19:49 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 12:19:49 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 12:19:49 INFO - Using env: {'DISPLAY': ':0', 12:19:49 INFO - 'HOME': '/home/cltbld', 12:19:49 INFO - 'LANG': 'en_US.UTF-8', 12:19:49 INFO - 'LANGUAGE': 'en_US:en', 12:19:49 INFO - 'LOGNAME': 'cltbld', 12:19:49 INFO - 'MAIL': '/var/mail/cltbld', 12:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:49 INFO - 'MOZ_NO_REMOTE': '1', 12:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:49 INFO - 'NO_EM_RESTART': '1', 12:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:49 INFO - 'PWD': '/builds/slave/test', 12:19:49 INFO - 'SHELL': '/bin/bash', 12:19:49 INFO - 'SHLVL': '1', 12:19:49 INFO - 'TERM': 'linux', 12:19:49 INFO - 'TMOUT': '86400', 12:19:49 INFO - 'USER': 'cltbld', 12:19:49 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', 12:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:49 INFO - '_': '/tools/buildbot/bin/python'} 12:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:49 INFO - Downloading/unpacking blobuploader==1.2.4 12:19:49 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 12:19:49 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 12:19:49 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 12:19:49 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 12:19:49 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 12:19:49 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 12:19:51 INFO - Downloading blobuploader-1.2.4.tar.gz 12:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:19:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:19:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:51 INFO - Downloading docopt-0.6.1.tar.gz 12:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:19:51 INFO - Installing collected packages: blobuploader, requests, docopt 12:19:51 INFO - Running setup.py install for blobuploader 12:19:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:19:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:19:51 INFO - Running setup.py install for requests 12:19:52 INFO - Running setup.py install for docopt 12:19:52 INFO - Successfully installed blobuploader requests docopt 12:19:52 INFO - Cleaning up... 12:19:52 INFO - Return code: 0 12:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:52 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 0x7fa32432af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e4160>, '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 0x26e5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e54f0>, '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': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', '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 12:19:52 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 12:19:52 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 12:19:52 INFO - Using env: {'DISPLAY': ':0', 12:19:52 INFO - 'HOME': '/home/cltbld', 12:19:52 INFO - 'LANG': 'en_US.UTF-8', 12:19:52 INFO - 'LANGUAGE': 'en_US:en', 12:19:52 INFO - 'LOGNAME': 'cltbld', 12:19:52 INFO - 'MAIL': '/var/mail/cltbld', 12:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:52 INFO - 'MOZ_NO_REMOTE': '1', 12:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:52 INFO - 'NO_EM_RESTART': '1', 12:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:52 INFO - 'PWD': '/builds/slave/test', 12:19:52 INFO - 'SHELL': '/bin/bash', 12:19:52 INFO - 'SHLVL': '1', 12:19:52 INFO - 'TERM': 'linux', 12:19:52 INFO - 'TMOUT': '86400', 12:19:52 INFO - 'USER': 'cltbld', 12:19:52 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', 12:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:52 INFO - '_': '/tools/buildbot/bin/python'} 12:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:52 INFO - Running setup.py (path:/tmp/pip-bzjHlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:52 INFO - Running setup.py (path:/tmp/pip-ovtkBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:52 INFO - Running setup.py (path:/tmp/pip-2WTd12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:52 INFO - Running setup.py (path:/tmp/pip-9ROCeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:52 INFO - Running setup.py (path:/tmp/pip-ZDjoNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:53 INFO - Running setup.py (path:/tmp/pip-lPPCM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:53 INFO - Running setup.py (path:/tmp/pip-dvR7qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:53 INFO - Running setup.py (path:/tmp/pip-y8ICaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:53 INFO - Running setup.py (path:/tmp/pip-_SO7vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:53 INFO - Running setup.py (path:/tmp/pip-iljjed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:53 INFO - Running setup.py (path:/tmp/pip-hfs2Lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:53 INFO - Running setup.py (path:/tmp/pip-mQ_jIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:53 INFO - Running setup.py (path:/tmp/pip-Zu5hAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:53 INFO - Running setup.py (path:/tmp/pip-v2BDg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:53 INFO - Running setup.py (path:/tmp/pip-7S8IJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:53 INFO - Running setup.py (path:/tmp/pip-sBWH0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:53 INFO - Running setup.py (path:/tmp/pip-wl517N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:19:53 INFO - Running setup.py install for manifestparser 12:19:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:19:53 INFO - Running setup.py install for mozcrash 12:19:54 INFO - Running setup.py install for mozdebug 12:19:54 INFO - Running setup.py install for mozdevice 12:19:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:19:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:19:54 INFO - Running setup.py install for mozfile 12:19:54 INFO - Running setup.py install for mozhttpd 12:19:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:19:54 INFO - Running setup.py install for mozinfo 12:19:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:19:54 INFO - Running setup.py install for mozInstall 12:19:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:19:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:19:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:19:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:19:54 INFO - Running setup.py install for mozleak 12:19:54 INFO - Running setup.py install for mozlog 12:19:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:19:54 INFO - Running setup.py install for moznetwork 12:19:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Running setup.py install for mozprocess 12:19:55 INFO - Running setup.py install for mozprofile 12:19:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Running setup.py install for mozrunner 12:19:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Running setup.py install for mozscreenshot 12:19:55 INFO - Running setup.py install for moztest 12:19:55 INFO - Running setup.py install for mozversion 12:19:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:19:55 INFO - Cleaning up... 12:19:55 INFO - Return code: 0 12:19:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:55 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 0x7fa32432af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e4160>, '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 0x26e5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e54f0>, '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': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', '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 12:19:55 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 12:19:55 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 12:19:55 INFO - Using env: {'DISPLAY': ':0', 12:19:55 INFO - 'HOME': '/home/cltbld', 12:19:55 INFO - 'LANG': 'en_US.UTF-8', 12:19:55 INFO - 'LANGUAGE': 'en_US:en', 12:19:55 INFO - 'LOGNAME': 'cltbld', 12:19:55 INFO - 'MAIL': '/var/mail/cltbld', 12:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:55 INFO - 'MOZ_NO_REMOTE': '1', 12:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:55 INFO - 'NO_EM_RESTART': '1', 12:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:55 INFO - 'PWD': '/builds/slave/test', 12:19:55 INFO - 'SHELL': '/bin/bash', 12:19:55 INFO - 'SHLVL': '1', 12:19:55 INFO - 'TERM': 'linux', 12:19:55 INFO - 'TMOUT': '86400', 12:19:55 INFO - 'USER': 'cltbld', 12:19:55 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', 12:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:55 INFO - '_': '/tools/buildbot/bin/python'} 12:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:55 INFO - Running setup.py (path:/tmp/pip-qxKPPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:55 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)) 12:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:55 INFO - Running setup.py (path:/tmp/pip-LaCC9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:56 INFO - Running setup.py (path:/tmp/pip-jswVjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:56 INFO - Running setup.py (path:/tmp/pip-kjCSxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:56 INFO - Running setup.py (path:/tmp/pip-8EBlOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:56 INFO - Running setup.py (path:/tmp/pip-nsEQF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:56 INFO - Running setup.py (path:/tmp/pip-hQwdsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:56 INFO - Running setup.py (path:/tmp/pip-QWWeH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:56 INFO - Running setup.py (path:/tmp/pip-M4MlVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:56 INFO - Running setup.py (path:/tmp/pip-9XGyqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:56 INFO - Running setup.py (path:/tmp/pip-whoKh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:56 INFO - Running setup.py (path:/tmp/pip-Cs3_gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:56 INFO - Running setup.py (path:/tmp/pip-ffJZVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:56 INFO - Running setup.py (path:/tmp/pip-D6swiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:56 INFO - Running setup.py (path:/tmp/pip-WXHHC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:56 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)) 12:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:56 INFO - Running setup.py (path:/tmp/pip-_TNFLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:57 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)) 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:57 INFO - Running setup.py (path:/tmp/pip-rOHnIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:57 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)) 12:19:57 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)) 12:19:57 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)) 12:19:57 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)) 12:19:57 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)) 12:19:57 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)) 12:19:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:58 INFO - Downloading blessings-1.6.tar.gz 12:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:19:59 INFO - Installing collected packages: blessings 12:19:59 INFO - Running setup.py install for blessings 12:19:59 INFO - Successfully installed blessings 12:19:59 INFO - Cleaning up... 12:19:59 INFO - Return code: 0 12:19:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:59 INFO - Reading from file tmpfile_stdout 12:19:59 INFO - Current package versions: 12:19:59 INFO - argparse == 1.2.1 12:19:59 INFO - blessings == 1.6 12:19:59 INFO - blobuploader == 1.2.4 12:19:59 INFO - docopt == 0.6.1 12:19:59 INFO - manifestparser == 1.1 12:19:59 INFO - mozInstall == 1.12 12:19:59 INFO - mozcrash == 0.17 12:19:59 INFO - mozdebug == 0.1 12:19:59 INFO - mozdevice == 0.48 12:19:59 INFO - mozfile == 1.2 12:19:59 INFO - mozhttpd == 0.7 12:19:59 INFO - mozinfo == 0.9 12:19:59 INFO - mozleak == 0.1 12:19:59 INFO - mozlog == 3.1 12:19:59 INFO - moznetwork == 0.27 12:19:59 INFO - mozprocess == 0.22 12:19:59 INFO - mozprofile == 0.28 12:19:59 INFO - mozrunner == 6.11 12:19:59 INFO - mozscreenshot == 0.1 12:19:59 INFO - mozsystemmonitor == 0.0 12:19:59 INFO - moztest == 0.7 12:19:59 INFO - mozversion == 1.4 12:19:59 INFO - psutil == 3.1.1 12:19:59 INFO - requests == 1.2.3 12:19:59 INFO - wsgiref == 0.1.2 12:19:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:59 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 0x7fa32432af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e4160>, '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 0x26e5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e54f0>, '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': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', '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 12:19:59 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 12:19:59 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 12:19:59 INFO - Using env: {'DISPLAY': ':0', 12:19:59 INFO - 'HOME': '/home/cltbld', 12:19:59 INFO - 'LANG': 'en_US.UTF-8', 12:19:59 INFO - 'LANGUAGE': 'en_US:en', 12:19:59 INFO - 'LOGNAME': 'cltbld', 12:19:59 INFO - 'MAIL': '/var/mail/cltbld', 12:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:59 INFO - 'MOZ_NO_REMOTE': '1', 12:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:59 INFO - 'NO_EM_RESTART': '1', 12:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:59 INFO - 'PWD': '/builds/slave/test', 12:19:59 INFO - 'SHELL': '/bin/bash', 12:19:59 INFO - 'SHLVL': '1', 12:19:59 INFO - 'TERM': 'linux', 12:19:59 INFO - 'TMOUT': '86400', 12:19:59 INFO - 'USER': 'cltbld', 12:19:59 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', 12:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:59 INFO - '_': '/tools/buildbot/bin/python'} 12:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:59 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)) 12:19:59 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)) 12:19:59 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)) 12:19:59 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)) 12:19:59 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)) 12:19:59 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)) 12:19:59 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)) 12:19:59 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)) 12:19:59 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)) 12:19:59 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)) 12:19:59 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)) 12:19:59 INFO - Cleaning up... 12:19:59 INFO - Return code: 0 12:19:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32432af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e4160>, '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 0x26e5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e54f0>, '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': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', '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 12:19: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', 'jsonschema'] in /builds/slave/test/build 12:19: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 jsonschema 12:19:59 INFO - Using env: {'DISPLAY': ':0', 12:19:59 INFO - 'HOME': '/home/cltbld', 12:19:59 INFO - 'LANG': 'en_US.UTF-8', 12:19:59 INFO - 'LANGUAGE': 'en_US:en', 12:19:59 INFO - 'LOGNAME': 'cltbld', 12:19:59 INFO - 'MAIL': '/var/mail/cltbld', 12:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:59 INFO - 'MOZ_NO_REMOTE': '1', 12:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:59 INFO - 'NO_EM_RESTART': '1', 12:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:59 INFO - 'PWD': '/builds/slave/test', 12:19:59 INFO - 'SHELL': '/bin/bash', 12:19:59 INFO - 'SHLVL': '1', 12:19:59 INFO - 'TERM': 'linux', 12:19:59 INFO - 'TMOUT': '86400', 12:19:59 INFO - 'USER': 'cltbld', 12:19:59 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', 12:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:59 INFO - '_': '/tools/buildbot/bin/python'} 12:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:59 INFO - Downloading/unpacking jsonschema 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:20:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:20:01 INFO - Downloading/unpacking functools32 (from jsonschema) 12:20: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 12:20: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 12:20: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 12:20: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 12:20: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 12:20: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 12:20:01 INFO - Downloading functools32-3.2.3-2.tar.gz 12:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:20:01 INFO - warning: no files found matching '*.txt' 12:20:01 INFO - no previously-included directories found matching 'build' 12:20:01 INFO - no previously-included directories found matching 'dist' 12:20:01 INFO - no previously-included directories found matching '.git*' 12:20:01 INFO - Installing collected packages: jsonschema, functools32 12:20:01 INFO - Running setup.py install for functools32 12:20:02 INFO - warning: no files found matching '*.txt' 12:20:02 INFO - no previously-included directories found matching 'build' 12:20:02 INFO - no previously-included directories found matching 'dist' 12:20:02 INFO - no previously-included directories found matching '.git*' 12:20:02 INFO - Successfully installed jsonschema functools32 12:20:02 INFO - Cleaning up... 12:20:02 INFO - Return code: 0 12:20:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:02 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 0x7fa32432af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e4160>, '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 0x26e5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e54f0>, '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': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', '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 12:20:02 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 12:20:02 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 12:20:02 INFO - Using env: {'DISPLAY': ':0', 12:20:02 INFO - 'HOME': '/home/cltbld', 12:20:02 INFO - 'LANG': 'en_US.UTF-8', 12:20:02 INFO - 'LANGUAGE': 'en_US:en', 12:20:02 INFO - 'LOGNAME': 'cltbld', 12:20:02 INFO - 'MAIL': '/var/mail/cltbld', 12:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:02 INFO - 'MOZ_NO_REMOTE': '1', 12:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:02 INFO - 'NO_EM_RESTART': '1', 12:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:02 INFO - 'PWD': '/builds/slave/test', 12:20:02 INFO - 'SHELL': '/bin/bash', 12:20:02 INFO - 'SHLVL': '1', 12:20:02 INFO - 'TERM': 'linux', 12:20:02 INFO - 'TMOUT': '86400', 12:20:02 INFO - 'USER': 'cltbld', 12:20:02 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', 12:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:02 INFO - '_': '/tools/buildbot/bin/python'} 12:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:02 INFO - Downloading/unpacking flake8 12:20: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 12:20: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 12:20: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 12:20: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 12:20: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 12:20: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 12:20:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:20:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:20:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:20:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:20:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:20:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:20:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:20:04 INFO - no previously-included directories found matching 'docs/_build' 12:20:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:20:04 INFO - Running setup.py install for pep8 12:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:20:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:20:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:20:05 INFO - no previously-included directories found matching 'docs/_build' 12:20:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:20:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:20:05 INFO - Cleaning up... 12:20:05 INFO - Return code: 0 12:20:05 INFO - Running post-action listener: _resource_record_post_action 12:20:05 INFO - Running post-action listener: _start_resource_monitoring 12:20:05 INFO - Starting resource monitoring. 12:20:05 INFO - ##### 12:20:05 INFO - ##### Running install step. 12:20:05 INFO - ##### 12:20:05 INFO - Running pre-action listener: _resource_record_pre_action 12:20:05 INFO - Running main action method: install 12:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:20:05 INFO - Reading from file tmpfile_stdout 12:20:05 INFO - Detecting whether we're running mozinstall >=1.0... 12:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:20:05 INFO - Reading from file tmpfile_stdout 12:20:05 INFO - Output received: 12:20:05 INFO - Usage: mozinstall [options] installer 12:20:05 INFO - Options: 12:20:05 INFO - -h, --help show this help message and exit 12:20:05 INFO - -d DEST, --destination=DEST 12:20:05 INFO - Directory to install application into. [default: 12:20:05 INFO - "/builds/slave/test"] 12:20:05 INFO - --app=APP Application being installed. [default: firefox] 12:20:05 INFO - mkdir: /builds/slave/test/build/application 12:20:05 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'] 12:20:05 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 12:20:21 INFO - Reading from file tmpfile_stdout 12:20:21 INFO - Output received: 12:20:21 INFO - /builds/slave/test/build/application/firefox/firefox 12:20:21 INFO - Running post-action listener: _resource_record_post_action 12:20:21 INFO - ##### 12:20:21 INFO - ##### Running run-tests step. 12:20:21 INFO - ##### 12:20:21 INFO - Running pre-action listener: _resource_record_pre_action 12:20:21 INFO - Running main action method: run_tests 12:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:20:21 INFO - Python 2.7.3 12:20:21 INFO - Return code: 0 12:20:21 INFO - grabbing minidump binary from tooltool 12:20:21 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')]} 12:20:21 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 0x26e4160>, '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 0x26e5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e54f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:20:21 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 12:20:21 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 12:20:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:20:21 INFO - Return code: 0 12:20:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:20:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:20:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:20:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:20:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:20:22 INFO - Return code: 0 12:20:22 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/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 12:20:22 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/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 12:20:22 INFO - Using env: {'DISPLAY': ':0', 12:20:22 INFO - 'HOME': '/home/cltbld', 12:20:22 INFO - 'LANG': 'en_US.UTF-8', 12:20:22 INFO - 'LANGUAGE': 'en_US:en', 12:20:22 INFO - 'LOGNAME': 'cltbld', 12:20:22 INFO - 'MAIL': '/var/mail/cltbld', 12:20:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:20:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:22 INFO - 'MOZ_NO_REMOTE': '1', 12:20:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:20:22 INFO - 'NO_EM_RESTART': '1', 12:20:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:22 INFO - 'PWD': '/builds/slave/test', 12:20:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:20:22 INFO - 'SHELL': '/bin/bash', 12:20:22 INFO - 'SHLVL': '1', 12:20:22 INFO - 'TERM': 'linux', 12:20:22 INFO - 'TMOUT': '86400', 12:20:22 INFO - 'USER': 'cltbld', 12:20:22 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676', 12:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:22 INFO - '_': '/tools/buildbot/bin/python'} 12:20:22 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/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 12:20:22 INFO - mozversion application_buildid: 20160316113845 12:20:22 INFO - mozversion application_changeset: 4116cafbb87dd251990450f8f90911beecbe0859 12:20:22 INFO - mozversion application_display_name: Nightly 12:20:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:20:22 INFO - mozversion application_name: Firefox 12:20:22 INFO - mozversion application_remotingname: firefox 12:20:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:20:22 INFO - mozversion application_vendor: Mozilla 12:20:22 INFO - mozversion application_version: 48.0a1 12:20:22 INFO - mozversion platform_buildid: 20160316113845 12:20:22 INFO - mozversion platform_changeset: 4116cafbb87dd251990450f8f90911beecbe0859 12:20:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:20:22 INFO - mozversion platform_version: 48.0a1 12:20:22 INFO - using testdate: 1458156022 12:20:22 INFO - actual date: 1458156022 12:20:22 INFO - starting webserver on 'localhost:52144' 12:20:22 INFO - SUITE-START | Running 2 tests 12:20:22 INFO - TEST-START | dromaeo_css 12:20:22 INFO - operating with platform_type : linux_ 12:20:22 INFO - Initialising browser for dromaeo_css test... 12:20:22 INFO - TEST-INFO | started process 7587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGyYgyV/profile http://localhost:52144/getInfo.html) 12:20:26 INFO - PROCESS | 7587 | __metrics Screen width/height:1600/1200 12:20:26 INFO - PROCESS | 7587 | colorDepth:24 12:20:26 INFO - PROCESS | 7587 | Browser inner width/height: 1024/697 12:20:26 INFO - PROCESS | 7587 | __metrics 12:20:27 ERROR - PROCESS | 7587 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:20:27 INFO - PROCESS | 7587 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 12:20:28 INFO - TEST-INFO | 7587: exit 0 12:20:28 INFO - Browser initialized. 12:20:28 INFO - Running cycle 1/1 for dromaeo_css test... 12:20:28 INFO - TEST-INFO | started process 7679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGyYgyV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:40 INFO - PROCESS | 7679 | RSS: Main: 153919488 12:20:40 INFO - PROCESS | 7679 | 12:21:31 INFO - PROCESS | 7679 | 1458156091434 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] 12:23:42 INFO - PROCESS | 7679 | Cycle 1(1): loaded http://localhost:52144/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52144/tests/dromaeo/cssquery-ext.html) 12:23:43 INFO - PROCESS | 7679 | RSS: Main: 277602304 12:23:43 INFO - PROCESS | 7679 | 12:26:46 INFO - PROCESS | 7679 | Cycle 1(1): loaded http://localhost:52144/tests/dromaeo/cssquery-ext.html (next: http://localhost:52144/tests/dromaeo/cssquery-jquery.html) 12:26:46 INFO - PROCESS | 7679 | RSS: Main: 240750592 12:26:46 INFO - PROCESS | 7679 | 12:29:48 INFO - PROCESS | 7679 | Cycle 1(1): loaded http://localhost:52144/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52144/tests/dromaeo/cssquery-mootools.html) 12:29:49 INFO - PROCESS | 7679 | RSS: Main: 238280704 12:29:49 INFO - PROCESS | 7679 | 12:32:51 INFO - PROCESS | 7679 | Cycle 1(1): loaded http://localhost:52144/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52144/tests/dromaeo/cssquery-prototype.html) 12:32:51 INFO - PROCESS | 7679 | RSS: Main: 222240768 12:32:51 INFO - PROCESS | 7679 | 12:35:54 INFO - PROCESS | 7679 | Cycle 1(1): loaded http://localhost:52144/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52144/tests/dromaeo/cssquery-yui.html) 12:35:55 INFO - PROCESS | 7679 | RSS: Main: 206987264 12:35:55 INFO - PROCESS | 7679 | 12:38:57 INFO - PROCESS | 7679 | Cycle 1(1): loaded http://localhost:52144/tests/dromaeo/cssquery-yui.html (next: http://localhost:52144/tests/dromaeo/cssquery-dojo.html) 12:38:57 INFO - PROCESS | 7679 | RSS: Main: 273629184 12:38:57 INFO - PROCESS | 7679 | 12:38:57 INFO - PROCESS | 7679 | __start_tp_report 12:38:57 INFO - PROCESS | 7679 | _x_x_mozilla_page_load 12:38:57 INFO - PROCESS | 7679 | _x_x_mozilla_page_load_details 12:38:57 INFO - PROCESS | 7679 | |i|pagename|runs| 12:38:57 INFO - PROCESS | 7679 | |0;dojo.html;2593.4164812917093;2686.8790904409325;2688.7311268873113;2692.08469120499;2710.8373497590146;4489.955100449003;4564.520725323843;4594.517575654559;4596.517365676606;4621.930671039937;4655.348251244828;4700.247960326348;4710.105080034791;4713.811447542094;4770.713757174572;4280.122574872159;4304.24675681756;4306;4325.351197320396;4429.202743506184;4245.23585754564;4356.760378179199;4357.346398040288;4399.318105693623;4408.5591440855815;4253.468316460442;4306.97846510767;4370.366296886966;4371.759553224571;4397.692161548693;4264.722793018444;4276.208901353229;4281.379200016011;4286.657067434598;4320.092780516095;4266.57334266574;4271.1671224111;4277.251480990814;4299.376590394375;4331.436913201295;4484.439445069366;4598.402207713009;4659.487456379796;4668.696534725266;4679.578837904571;4972.229304457815;4999.975000125012;5000.47495013022;5003.699778013331;5044.268581055763;5039.77321020555;5044.697318160922;5046.5710414614805;5047.570956468705;5083.923741143886;4586.633069354477;4691.554302341272;4717.528247175255;4755.881102972384;4768.7615619218905;5135.204043373283;5157.561607263425;5165.48345165488;5166.689998600021;5170.45710200431;4818.518148185223;4932.876678083005;4933.802647894116;4947.307376967227;4982.750862456863;5005.974970125126;5021.372328458942;5050.6464547482055;5070;5079.212722028092;4948.035133149001;4949.57928576075;4954.677945933503;4956.975215123901;4995.9500404996215;4835.105505481497;4918.0901533216465;4930.112579735682;4932.1122198004705;4983.25251212321;3879.2629400414394;3895.02624343914;3936.9015774605864;3945.92108157841;3947.3289540777564;3499.4245346668094;3500.1949551603275;3510.613832478425;3515.6308587598446;3541.610422853484;4238.449001629769;4362.716423432466;4364.388985542027;4365.978170109192;4397.6921615487245;4954.380702412199;4965.1807451770055;4981.37732783402;5025.84922452327;5027.296178535008;4252.29837076885;4258.276093064186;4259.446271984622;4293.6779741518885;4301.741895486281;4408;4429.645628349725;4448.088141930896;4456.398386217819;4536.6143877770755;4787.497312782108;4791.233402655558;4792.472827988988;4802.351682522884;4843.297721830315;5040.395152581714;5044.470330615232;5046.571041461517;5047.722375269395;5059.974700126476;4587.082583483383;4727.030958653399;4771.403574553181;4818.4217893852965;4830.2513110467935;4897.534734200245;4917.877053073702;4918.163912135017;4923.187674033744;4963;4931.753412329297;4991.176455884738;4997.350344455198;5005.974970125126;5036.521530454601;4729.668923175483;4863.270509423473;4874.926876096791;4916.827911023097;4922.015596880567;4819.7108173509705;4821.397325334333;4831.202851529459;4839;4898.142825005681;4741.407324084489;4765.547273009059;4772.570468657837;4782.473927868002;4818.6626936114135;4754.619630429626;4804.279358096313;4878.365812444502;4879.487653796442;4964.925526117039;4716.457607375059;4752.596029337545;4804.735739534359;4857;4857.95142048575 12:38:57 INFO - PROCESS | 7679 | |1;ext.html;519.9948000519994;543.2421771628581;546.7184400033982;564.5652847307574;574.052812858783;28405.85797071014;35954.2809143817;36537.08657283566;36549.81725091371;36708.082297942565;39233.803830980876;39687.61874287545;39746.205075898535;39788;39840.80079599605;7725.5364678119495;7911.683532658687;7924;7924.088729796061;7934.44458887878;7727.227277272284;7854.3716502679645;7854.921450785476;7855.764327070197;8041.437099403044;8006.23940725633;8075.152109028556;8082.07056188537;8082.959585202066;8088.514689118642;7950.642221100035;8010.198980101973;8017.238362355567;8020.0375954885785;8023.919760802376;7879.290863822283;7994.760157195294;8011.639476223584;8012.479188852706;8015.839683206304;38302.23395532102;38707.612923870685;38721.61278387236;38775;38809.417858732144;3239.3683231769814;3264.396086723964;3266.657001014883;3294.7199488043543;3531.4349704047486;27824.721752782414;28078.859605702044;28365.290867728265;28899.855500722573;28935.42129157405;3421.4525675891737;3425.657434256579;3429.5884493860895;3446.4485682290715;3568.5360903082433;250298;252424;252892;253142;253275.73362133256;43371.78314108472;43935.56064439379;56444.71777641168;57551.13673294904;57685.71157144271;41881.37177942333;42069;42119.57880421218;42139;42140;12971.870281297255;13121.67195820093;13137.60587182386;13198.47206111764;13222.074454788073;10260;10379.169666426667;10391.896081039244;10398.324108932895;10400.58397664085;14733.705325893636;14737.778933316009;14765.33555989983;14801.629959251104;14891.404343826342;5810.970945145332;5925.111233314951;5935.169076329317;5992.58051936369;5992.730327135289;912.2246090822748;912.9132732390412;935.2144198872979;964.8938616752151;1006.6023920551341;27310.5903411449;27723.752431140245;27742.44515109727;27915;28230;1002.8395456726888;1004.6684594083935;1006.3961623026125;1013.1540163963173;1022.2384323678907;14179.85820141806;14549.34527946245;14662.853371466363;14854.2572871356;14893.851061489464;302332;697690;709436;712449;715724;51120.744396278526;51508.484915151115;51862.222066669034;51897.48102519002;51957.740211298704;1119.5633702855894;1206;1233.993830030862;1265.6076616248993;1279.5201799325253;25545.744542554337;27602.861985689942;29125.563116553694;29370.41259174762;29983.4003319928;39276.2144757109;39469.60530394659;39752.60247397605;39871.80064099661;39945.60054399419;230638;232164;232292;232622;234805;26603.33491662724;30640.84679576588;31428.685713142575;31551.21121971877;31618.209544761565;34423;36369;39368.10978695463;39644.801775990934;40108.99727506836;33919.491207632396;34126;34287.14282142966;34469.482957756154;35365;34234.65765342315;34356.14109647279;34679.65320346764;34773;35206.29587408289;33843;33951.66048339485;34113.48829767506;34169;34590.82704586461;28941.56587651145;31084.22289442782;31132.22169445782;31136.457756422406;31173.220669483446;23650.88174559185;23875.522489550458;23954.28137155888;24047.51904961926;24199.63700544458 12:38:57 INFO - PROCESS | 7679 | |2;jquery.html;338.03322497656706;353.82662495377275;357.93736096183176;359.96940260077895;365.398918778609;15627.609309767262;16134.193290335481;16306.510804675863;16940.66118677626;16941.407050753227;9543.618255269781;9743.366681165737;10881.347119172855;15196.772048419283;15207.84792152078;4619.3071039344195;4769.713817170964;4770.165221086313;4773.546513081252;4794.736289504076;3462.6191118976894;4749.453812811519;6014.188084608588;6026.126211699301;6028.63828170309;5936.732847021873;5942.821715348547;5948.702564871739;5969.13447550105;5971.0744834550715;5737.7991770288045;5914;5946.821595352147;5965.075413310944;5966.40335966402;5242.370915490127;5255;5280.709560974145;5289.550388217006;5307.628466007381;15733.977291476018;18899.244030238773;19989.500787440855;19991.80008199914;20014.79985200144;2007.7490313710787;2043.8978051097533;2184.2791878680155;2494.077191439161;2544.7328030556896;9014.323925705598;9068.77328066797;9332.253419726405;9375.718728438158;9560.521973901277;1787.0796539782023;1794.9371771988049;1821.5537193387704;1830.094103418803;1842.4656849513624;60586.45601579899;60846.69576652133;61516.38483615196;61616;61625;10290.434026128634;10301.74245643865;10395.116415104801;10396.116330112025;10541.947290263499;13365.33173341329;13518.864811351761;13541.66145846342;13541.661458463617;13555.864441355658;7003.54476958996;7199.964000180071;7255.536252720689;7342.375898048619;7353.154387245429;6887.690053947585;6893.241743408221;6911.965440172868;6915.135608048994;6993.160820701549;4395.318725597537;4397.1865204937185;4398.824047038082;4467.664925130628;4526.207913615104;1806.9638607227782;1836.173721825184;1842.640685066399;1861.1066687989842;1882.585831117152;874.501534125555;887.2990337633327;916.4272329793879;975.0882924465506;1012.3925644613321;15893.920530397274;16495.587610309838;16506.917465412596;16556.66886662284;16611.83388166127;872.7818045488627;885.6059053721033;895.3195571365809;941.6986564299358;949.539473355422;9007.414518056305;9263.25893928484;9424.670136545188;9585.424874507551;9702.951485242529;420258;427622;427817;428069;435888.6672366286;54627;64362;64464.355356445834;69355.49189302679;72839.2716072843;898.4968417686117;898.8427025270552;926.2493886554417;926.6200857648332;938.0291398402757;14163.36264868104;14492.565223043326;14554.85445145535;14674.926625366805;14849;31398.372032558764;31802.204944876565;32088.358232834744;32463;32554.186145345608;48174;48234.27648585344;48314;48344.274835876786;48351.75824120857;7560.206178351194;7561.697532098655;7566.583837888969;7576.772696819105;7638.350740187147;7208.819779505554;9817.7727784027;9961.452120133463;11558.826617600911;11744.236624619372;8680.435771674822;9372.578233979351;9529.094736000068;9715.854262186214;10043.246756493147;10002.24983126254;10122.8481572775;10289.794204116026;10337.328073675488;10352.275340726379;8713.25937295337;9986.201103911815;10187.949060254949;10252.179825613784;10252.333598316085;7111.928880711127;7453.701851925862;7496.550206987598;7611.695532178873;7743.148253692202;9769.267304952014;10135.54390052464;10325.32885362449;10448.850626430934;10549.419781911762 12:38:57 INFO - PROCESS | 7679 | |3;mootools.html;1270.6696258972665;1415.76639854424;1422.1609250542178;1570.3169121432177;1782.171290349987;6962.16454025517;7100.644967751605;7107.6090815005155;7144.321289477498;7148.213696493388;7043.542169758962;7182.461315401352;7202.747903823354;7227;7251.927480725191;1918.194358369488;1966.0857701168954;2138.7326584176976;2239.8208143348493;2265.7507674155913;2212.977870221301;2220.7668194839553;2222.7888350606668;2223.2440970070174;2223.655333423322;2140.357892632212;2159.74083110027;2170.0560256288486;2256.244158207003;2258.4579700871755;2193.6599827026835;2212.977870221301;2220.766819483947;2221.655643375271;2223.0774228695072;2238.23899874042;2264.6036943534814;2264.7395549511853;2267.2971378872603;2271.5911135995516;7197.676104575306;7272.090988626422;7277.3814225790875;7289.307515785992;7292.307230813064;4429.313456414261;4487.102579484116;4534.433195850519;4537.38745269391;4540.795664195086;2859.9428011439863;2883.0774152271283;2983.8358890261243;2990.1627544287635;3009.8043627164384;943.8018016216603;944.3200895355333;966.120830044663;967.400211868639;981.3375971219398;9974.451405172713;10007.49962501872;10019.148372388356;10047.196224302039;10050.64822731201;4210.936835947463;4247.086876321544;4308.4399028126145;4308.870733877989;4342.174986752507;8507.787305317293;8531.488110713377;8568.657253709782;8570.057293697688;8600.354973377021;4531.093781243764;4536.61438777701;4538.29656403258;4538.841140560065;4540.727556346564;3547.6629720176543;3599.352116618981;3626.165981824195;3633.8909832705062;4086.264472394938;3461.2904354607244;3528.576570811519;3581.606023337431;3651.94522082169;3653.159773252167;1196.174639498743;1215.975680486403;1218.792805223114;1225.136278923357;1229.3361584744139;934.9532523373804;961.4808003678075;962.0139357158968;1006.4716024087267;1219.896308813743;7022.789316320519;7024.754133605402;7040.119985001875;7063.646817659199;7066;1042.7080417483116;1061.5117046158698;1065.3714308557987;1090.9890901091046;1092.8032954068185;5348.064088784447;5387.838364849061;5396.622236443412;5440.619156658996;5447.618666693294;8512.787180320418;8612.8708069379;8615.095414981337;8626.913730862736;8712.564371781385;8444.45111067791;8501.914980850235;8534.231919127309;8540.188682075193;8560.186782255676;6646.767363142267;6702.19573651165;6802.659867006729;6843.315668433216;6858.794236172823;6749.93250067493;6759.628220447726;6781.38967492928;6785.5250132490255;6957.512974091967;7793.532388056735;8007.679692812222;8128.715494957648;8132.2680958714;8158.143394943683;8108.675652973815;8231.053428855519;8365.790855228424;8377.204165604258;8391.244787969112;5480.945190548044;5949.940500594938;6117.449429551361;6176.845578860564;6302.243730752339;6897.7240910363025;6930;6946.305369463013;6955.756548520778;6966.756163534252;5966.820995370146;6171.691415429121;6229.875402492015;6250.281217660027;6379.457746091449;6129.3564175762685;6215.316315205414;6252.468540173954;6283.214598175228;6334.92306307938;6397.232332120176;6591.868162636624;6592.901106483502;6593.044008618819;6607.603543787388;5990.64056156632;6054.54590905675;6058.151858739692;6067.211262535842;6069.787557435468;6067.089936509382;6239.5008399327035;6240.4071613196675;6240.500759939103;6253.78111766086 12:38:57 INFO - PROCESS | 7679 | |4;prototype.html;320.82515029309053;323.24683487474186;324.44681817501146;327.2440662070616;330.20585491892;5374.140137577989;5489.149181876811;5498.4501549845;5522.944770552298;5529.751161197746;5379;5400.729963501819;5412.296401467804;5426.240326354314;5439.809606663767;4018.8191531381012;4134.8139333729905;4188;4205.831766729335;4236.597523235288;4226.936595951063;4227.87316380509;4228.386883901832;4237.6186143247105;4239.364095385686;4188.97905510472;4192.909843440712;4198.643115335185;4199.202151591188;4204.789760511978;4004.479417675698;4091.0999580092334;4164.9583504164875;4165.58344165584;4179.561146079648;3671.2473942841652;3673.963260367389;3674.6141655126094;3682.8710995115043;3683.37382644951;5208.088584497736;5210.531052205281;5211.140161873324;5213.087709650796;5214.400343960455;4844.685095468783;4851.126797176506;4851.490593487703;4856.198727210006;4858.125537403302;5705.144228365737;5709.457601527848;5709.74306156224;5713.457221563986;5713.571482138815;3956.3274243378405;4050.615191556827;4061.2283666103344;4063.634272915422;4064.7764372959477;5922.052471604566;6012.398760123996;6015.849603759897;6022.939770602326;6024.57827952048;4145.709800313949;4166.58334166587;4171.144915292358;4171.666266698657;4175.123224122907;4234.978825105854;4239.258129827268;4240.6395456385935;4242.066745316026;4245.936310955338;4810.903781924412;4814.975925120422;4816.060868130681;4816.446108697474;4827.927581086286;5730.541556675456;5738.426157384311;5743.827685169452;5744.798932037359;5747.8563035924435;1413.046193819168;1490.381491680962;1498.820141583017;1501.5045035138378;1503.7669161280019;910.6402970826487;944.5324564340696;946.1910066892708;946.4652471353663;982.2093214962024;4849.684770489906;4870.391201099863;4911.533404326655;4963.975180124148;5009.524095210949;5994.430529099728;6000;6001.279846418458;6009.549283803733;6022.337542870281;5071.112555302881;5071.46749591295;5071.54356107952;5077.365329333833;5081.491850814963;3182.98408507956;3214.8553315100407;3219.388316219911;3222.85497152624;3235.2397186661115;5655.971720141373;5656.660600363992;5660.235868157828;5660.830175094754;5664.971675141598;5928.110783382441;6192.690365481708;6196.442320191204;6201.7519299228425;6207.224096987877;5647.491725744702;5659.688717120515;5663.745131469093;5678.3753787084215;5678.77284908599;6020.458158765732;6024.638521688713;6027.57806953509;6028.487578555696;6033.12519684652;5881.7647294107755;5892.204552385373;5897.5576831736935;5899.292084949662;5902.2622172228475;5444.782208711766;5667.121596152438;5672.347680016851;5677.886442271214;5679.375268720355;4027.0737730321603;4047.372657238133;4050.8784736457956;4059.715819892579;4082.0203151242895;5971.820845374646;5973.342932277359;5976.462118409364;5981.461668449861;5984.730687119177;5745;5772.740226689725;5778.306603207642;5780;5787.450192231731;5767.250257466502;5771.5671324649975;5782.2483077199695;5782.335031471434;5785.797497087582;5438.619296649196;5640.407757185437;5666.263385759825;5675.489205971482;5680.147977803363;5811.070228763378;5820.970895145497;5823.767049317979;5824;5830.708464576839;5662.971685141548;5671.829845104653;5686.317641883001;5689;5693.117566777156 12:38:57 INFO - PROCESS | 7679 | |5;yui.html;638.4222278837651;685.6880119545607;699.115618742291;723.8552289542091;739.6117038554761;11606.709832254188;11689.883101168985;11709.473073711682;11711.472983715721;11720.355380454082;11828.822567661471;12339.938300308486;12392.31842248676;12450.43973021214;12513.124081314312;642.4057746584414;789.5302295134386;794.2732399854126;805.4683908620283;812.4150611559668;810;812.5733989655448;814.6497006287294;814.7189219719187;816.5060138616141;852.0457088061349;854.5043874552775;855.0252711908398;855.3969451536683;856.2507805670039;667.4526887951881;828.98342033159;848.4951453884929;849.4563479373206;851.1318455175717;619.0250355689761;619.071392910634;619.1084837833505;620.0822782282203;620.3238470067648;11492.770144597145;11526;11536.480858361394;11589.188756787029;11597.362145082017;11915.2255103418;12282.938585307016;12320.876791232153;12599.874001259961;12681.746365072648;9782.364146330538;9814.754631134207;9834.557444914995;9917.801643967081;9933.453660048766;3285.2772390074383;3347.380734564089;3349.8325083745717;3371.881984130568;3427.246005878703;41761.58238417638;42098.36852447216;42122.78938605318;42160.789196053825;42310.78844605788;9819.607215711292;10091.192704583616;10132.290739648153;10217.13154381886;10281.845772313422;17586.47240582759;17591.560210994572;17857.107144642716;17942.820571794375;17943.371981980566;6706.664666766642;6819.556728812611;6856.588604683735;6906.723731050702;6929.203141638776;3748.5501739790852;3772.490713753608;3791.3554695701796;3825.407061905409;3845.8269377878064;2572.164046684835;2577.9355516111873;2583.4962182374256;2587.706146926537;2592.546304396723;504.07250658788007;506.3923292049555;513.3377942454192;516.9431362550116;518.0416229974592;429.4738944792667;530.5728888244922;544.1429748146685;547.8110052032042;568.8378812038549;7328.267173282629;7606.695732170651;7675.846483070419;7836.138024817265;7867.803304917423;406.92268468991386;438.8485972339538;480.70917095156926;484.10440684733663;496.19616221721043;3309.851056702454;3345.180430794471;3377.324535092991;3536;3588.1567831560083;49782.75108624506;51555.48444515582;51686;51698.22452663213;51702.48297517052;46021.76989115033;46039.309410358874;46391.768041160256;46433.76783116063;46544;39891.60108398937;40102.39846402306;40331.59668403337;41163;41371.37942930858;6866.313368663094;6916.757913473004;6967.8606427870145;6980.7905762827195;6995.545289556163;30994.380112398077;31321.8433907829;32240.355192895542;32289.35421291514;32932.67067329296;37662.435063474615;39912.60087399089;40177.59822401738;40944.59055409408;41115;9054.185123338932;9068.410553314014;9127.726168214964;9161;9218.170364667212;9686.903130968882;9742;9778.462184579916;9865.26010549226;10048.849267261143;9077.727668169966;9197.218236449977;9210.355275130945;9237.907620923974;9388.67139650109;9125.087491250822;9155.176034156957;9188.173064424234;9202.493862837608;9206.723798286062;9071.319651026068;9161.633534658538;9228.123328283802;9345.252379809735;9384.202342800938;8121.796955075934;8231.753047408587;8294.170582941657;8342.29090527312;8462.153784621489;8250.051244106764;8738.956305218688;8915.55422228873;9007.144321289466;9041.367104302899 12:38:57 INFO - PROCESS | 7679 | __end_tp_report 12:38:57 INFO - PROCESS | 7679 | __start_cc_report 12:38:57 INFO - PROCESS | 7679 | _x_x_mozilla_cycle_collect,1111 12:38:57 INFO - PROCESS | 7679 | __end_cc_report 12:38:57 INFO - PROCESS | 7679 | __startTimestamp1458157137755__endTimestamp 12:38:57 INFO - PROCESS | 7679 | 12:38:57 INFO - PROCESS | 7679 | ------- Summary: start ------- 12:38:57 INFO - PROCESS | 7679 | Number of tests: 6 12:38:57 INFO - PROCESS | 7679 | 12:38:57 INFO - PROCESS | 7679 | [#0] dojo.html Cycles:165 Average:4608.80 Median:4770.71 stddev:499.33 (10.5%) stddev-sans-first:475.17 12:38:57 INFO - PROCESS | 7679 | Values: 2593.4 2686.9 2688.7 2692.1 2710.8 4490.0 4564.5 4594.5 4596.5 4621.9 4655.3 4700.2 4710.1 4713.8 4770.7 4280.1 4304.2 4306.0 4325.4 4429.2 4245.2 4356.8 4357.3 4399.3 4408.6 4253.5 4307.0 4370.4 4371.8 4397.7 4264.7 4276.2 4281.4 4286.7 4320.1 4266.6 4271.2 4277.3 4299.4 4331.4 4484.4 4598.4 4659.5 4668.7 4679.6 4972.2 5000.0 5000.5 5003.7 5044.3 5039.8 5044.7 5046.6 5047.6 5083.9 4586.6 4691.6 4717.5 4755.9 4768.8 5135.2 5157.6 5165.5 5166.7 5170.5 4818.5 4932.9 4933.8 4947.3 4982.8 5006.0 5021.4 5050.6 5070.0 5079.2 4948.0 4949.6 4954.7 4957.0 4996.0 4835.1 4918.1 4930.1 4932.1 4983.3 3879.3 3895.0 3936.9 3945.9 3947.3 3499.4 3500.2 3510.6 3515.6 3541.6 4238.4 4362.7 4364.4 4366.0 4397.7 4954.4 4965.2 4981.4 5025.8 5027.3 4252.3 4258.3 4259.4 4293.7 4301.7 4408.0 4429.6 4448.1 4456.4 4536.6 4787.5 4791.2 4792.5 4802.4 4843.3 5040.4 5044.5 5046.6 5047.7 5060.0 4587.1 4727.0 4771.4 4818.4 4830.3 4897.5 4917.9 4918.2 4923.2 4963.0 4931.8 4991.2 4997.4 5006.0 5036.5 4729.7 4863.3 4874.9 4916.8 4922.0 4819.7 4821.4 4831.2 4839.0 4898.1 4741.4 4765.5 4772.6 4782.5 4818.7 4754.6 4804.3 4878.4 4879.5 4964.9 4716.5 4752.6 4804.7 4857.0 4858.0 12:38:57 INFO - PROCESS | 7679 | 12:38:57 INFO - PROCESS | 7679 | [#1] ext.html Cycles:180 Average:50852.21 Median:18957.97 stddev:114444.20 (603.7%) stddev-sans-first:114702.85 12:38:57 INFO - PROCESS | 7679 | Values: 520.0 543.2 546.7 564.6 574.1 28405.9 35954.3 36537.1 36549.8 36708.1 39233.8 39687.6 39746.2 39788.0 39840.8 7725.5 7911.7 7924.0 7924.1 7934.4 7727.2 7854.4 7854.9 7855.8 8041.4 8006.2 8075.2 8082.1 8083.0 8088.5 7950.6 8010.2 8017.2 8020.0 8023.9 7879.3 7994.8 8011.6 8012.5 8015.8 38302.2 38707.6 38721.6 38775.0 38809.4 3239.4 3264.4 3266.7 3294.7 3531.4 27824.7 28078.9 28365.3 28899.9 28935.4 3421.5 3425.7 3429.6 3446.4 3568.5 250298.0 252424.0 252892.0 253142.0 253275.7 43371.8 43935.6 56444.7 57551.1 57685.7 41881.4 42069.0 42119.6 42139.0 42140.0 12971.9 13121.7 13137.6 13198.5 13222.1 10260.0 10379.2 10391.9 10398.3 10400.6 14733.7 14737.8 14765.3 14801.6 14891.4 5811.0 5925.1 5935.2 5992.6 5992.7 912.2 912.9 935.2 964.9 1006.6 27310.6 27723.8 27742.4 27915.0 28230.0 1002.8 1004.7 1006.4 1013.2 1022.2 14179.9 14549.3 14662.9 14854.3 14893.9 302332.0 697690.0 709436.0 712449.0 715724.0 51120.7 51508.5 51862.2 51897.5 51957.7 1119.6 1206.0 1234.0 1265.6 1279.5 25545.7 27602.9 29125.6 29370.4 29983.4 39276.2 39469.6 39752.6 39871.8 39945.6 230638.0 232164.0 232292.0 232622.0 234805.0 26603.3 30640.8 31428.7 31551.2 31618.2 34423.0 36369.0 39368.1 39644.8 40109.0 33919.5 34126.0 34287.1 34469.5 35365.0 34234.7 34356.1 34679.7 34773.0 35206.3 33843.0 33951.7 34113.5 34169.0 34590.8 28941.6 31084.2 31132.2 31136.5 31173.2 23650.9 23875.5 23954.3 24047.5 24199.6 12:38:57 INFO - PROCESS | 7679 | 12:38:57 INFO - PROCESS | 7679 | [#2] jquery.html Cycles:180 Average:24313.39 Median:26484.37 stddev:70092.68 (264.7%) stddev-sans-first:70266.19 12:38:57 INFO - PROCESS | 7679 | Values: 338.0 353.8 357.9 360.0 365.4 15627.6 16134.2 16306.5 16940.7 16941.4 9543.6 9743.4 10881.3 15196.8 15207.8 4619.3 4769.7 4770.2 4773.5 4794.7 3462.6 4749.5 6014.2 6026.1 6028.6 5936.7 5942.8 5948.7 5969.1 5971.1 5737.8 5914.0 5946.8 5965.1 5966.4 5242.4 5255.0 5280.7 5289.6 5307.6 15734.0 18899.2 19989.5 19991.8 20014.8 2007.7 2043.9 2184.3 2494.1 2544.7 9014.3 9068.8 9332.3 9375.7 9560.5 1787.1 1794.9 1821.6 1830.1 1842.5 60586.5 60846.7 61516.4 61616.0 61625.0 10290.4 10301.7 10395.1 10396.1 10541.9 13365.3 13518.9 13541.7 13541.7 13555.9 7003.5 7200.0 7255.5 7342.4 7353.2 6887.7 6893.2 6912.0 6915.1 6993.2 4395.3 4397.2 4398.8 4467.7 4526.2 1807.0 1836.2 1842.6 1861.1 1882.6 874.5 887.3 916.4 975.1 1012.4 15893.9 16495.6 16506.9 16556.7 16611.8 872.8 885.6 895.3 941.7 949.5 9007.4 9263.3 9424.7 9585.4 9703.0 420258.0 427622.0 427817.0 428069.0 435888.7 54627.0 64362.0 64464.4 69355.5 72839.3 898.5 898.8 926.2 926.6 938.0 14163.4 14492.6 14554.9 14674.9 14849.0 31398.4 31802.2 32088.4 32463.0 32554.2 48174.0 48234.3 48314.0 48344.3 48351.8 7560.2 7561.7 7566.6 7576.8 7638.4 7208.8 9817.8 9961.5 11558.8 11744.2 8680.4 9372.6 9529.1 9715.9 10043.2 10002.2 10122.8 10289.8 10337.3 10352.3 8713.3 9986.2 10187.9 10252.2 10252.3 7111.9 7453.7 7496.6 7611.7 7743.1 9769.3 10135.5 10325.3 10448.9 10549.4 12:38:57 INFO - PROCESS | 7679 | 12:38:57 INFO - PROCESS | 7679 | [#3] mootools.html Cycles:180 Average:5114.29 Median:6123.40 stddev:2607.19 (42.6%) stddev-sans-first:2598.49 12:38:57 INFO - PROCESS | 7679 | Values: 1270.7 1415.8 1422.2 1570.3 1782.2 6962.2 7100.6 7107.6 7144.3 7148.2 7043.5 7182.5 7202.7 7227.0 7251.9 1918.2 1966.1 2138.7 2239.8 2265.8 2213.0 2220.8 2222.8 2223.2 2223.7 2140.4 2159.7 2170.1 2256.2 2258.5 2193.7 2213.0 2220.8 2221.7 2223.1 2238.2 2264.6 2264.7 2267.3 2271.6 7197.7 7272.1 7277.4 7289.3 7292.3 4429.3 4487.1 4534.4 4537.4 4540.8 2859.9 2883.1 2983.8 2990.2 3009.8 943.8 944.3 966.1 967.4 981.3 9974.5 10007.5 10019.1 10047.2 10050.6 4210.9 4247.1 4308.4 4308.9 4342.2 8507.8 8531.5 8568.7 8570.1 8600.4 4531.1 4536.6 4538.3 4538.8 4540.7 3547.7 3599.4 3626.2 3633.9 4086.3 3461.3 3528.6 3581.6 3651.9 3653.2 1196.2 1216.0 1218.8 1225.1 1229.3 935.0 961.5 962.0 1006.5 1219.9 7022.8 7024.8 7040.1 7063.6 7066.0 1042.7 1061.5 1065.4 1091.0 1092.8 5348.1 5387.8 5396.6 5440.6 5447.6 8512.8 8612.9 8615.1 8626.9 8712.6 8444.5 8501.9 8534.2 8540.2 8560.2 6646.8 6702.2 6802.7 6843.3 6858.8 6749.9 6759.6 6781.4 6785.5 6957.5 7793.5 8007.7 8128.7 8132.3 8158.1 8108.7 8231.1 8365.8 8377.2 8391.2 5480.9 5949.9 6117.4 6176.8 6302.2 6897.7 6930.0 6946.3 6955.8 6966.8 5966.8 6171.7 6229.9 6250.3 6379.5 6129.4 6215.3 6252.5 6283.2 6334.9 6397.2 6591.9 6592.9 6593.0 6607.6 5990.6 6054.5 6058.2 6067.2 6069.8 6067.1 6239.5 6240.4 6240.5 6253.8 12:38:57 INFO - PROCESS | 7679 | 12:38:57 INFO - PROCESS | 7679 | [#4] prototype.html Cycles:180 Average:4770.84 Median:5439.21 stddev:1411.00 (25.9%) stddev-sans-first:1374.86 12:38:57 INFO - PROCESS | 7679 | Values: 320.8 323.2 324.4 327.2 330.2 5374.1 5489.1 5498.5 5522.9 5529.8 5379.0 5400.7 5412.3 5426.2 5439.8 4018.8 4134.8 4188.0 4205.8 4236.6 4226.9 4227.9 4228.4 4237.6 4239.4 4189.0 4192.9 4198.6 4199.2 4204.8 4004.5 4091.1 4165.0 4165.6 4179.6 3671.2 3674.0 3674.6 3682.9 3683.4 5208.1 5210.5 5211.1 5213.1 5214.4 4844.7 4851.1 4851.5 4856.2 4858.1 5705.1 5709.5 5709.7 5713.5 5713.6 3956.3 4050.6 4061.2 4063.6 4064.8 5922.1 6012.4 6015.8 6022.9 6024.6 4145.7 4166.6 4171.1 4171.7 4175.1 4235.0 4239.3 4240.6 4242.1 4245.9 4810.9 4815.0 4816.1 4816.4 4827.9 5730.5 5738.4 5743.8 5744.8 5747.9 1413.0 1490.4 1498.8 1501.5 1503.8 910.6 944.5 946.2 946.5 982.2 4849.7 4870.4 4911.5 4964.0 5009.5 5994.4 6000.0 6001.3 6009.5 6022.3 5071.1 5071.5 5071.5 5077.4 5081.5 3183.0 3214.9 3219.4 3222.9 3235.2 5656.0 5656.7 5660.2 5660.8 5665.0 5928.1 6192.7 6196.4 6201.8 6207.2 5647.5 5659.7 5663.7 5678.4 5678.8 6020.5 6024.6 6027.6 6028.5 6033.1 5881.8 5892.2 5897.6 5899.3 5902.3 5444.8 5667.1 5672.3 5677.9 5679.4 4027.1 4047.4 4050.9 4059.7 4082.0 5971.8 5973.3 5976.5 5981.5 5984.7 5745.0 5772.7 5778.3 5780.0 5787.5 5767.3 5771.6 5782.2 5782.3 5785.8 5438.6 5640.4 5666.3 5675.5 5680.1 5811.1 5821.0 5823.8 5824.0 5830.7 5663.0 5671.8 5686.3 5689.0 5693.1 12:38:57 INFO - PROCESS | 7679 | 12:38:57 INFO - PROCESS | 7679 | [#5] yui.html Cycles:180 Average:12281.93 Median:524.31 stddev:14234.42 (2714.9%) stddev-sans-first:14247.50 12:38:57 INFO - PROCESS | 7679 | Values: 638.4 685.7 699.1 723.9 739.6 11606.7 11689.9 11709.5 11711.5 11720.4 11828.8 12339.9 12392.3 12450.4 12513.1 642.4 789.5 794.3 805.5 812.4 810.0 812.6 814.6 814.7 816.5 852.0 854.5 855.0 855.4 856.3 667.5 829.0 848.5 849.5 851.1 619.0 619.1 619.1 620.1 620.3 11492.8 11526.0 11536.5 11589.2 11597.4 11915.2 12282.9 12320.9 12599.9 12681.7 9782.4 9814.8 9834.6 9917.8 9933.5 3285.3 3347.4 3349.8 3371.9 3427.2 41761.6 42098.4 42122.8 42160.8 42310.8 9819.6 10091.2 10132.3 10217.1 10281.8 17586.5 17591.6 17857.1 17942.8 17943.4 6706.7 6819.6 6856.6 6906.7 6929.2 3748.6 3772.5 3791.4 3825.4 3845.8 2572.2 2577.9 2583.5 2587.7 2592.5 504.1 506.4 513.3 516.9 518.0 429.5 530.6 544.1 547.8 568.8 7328.3 7606.7 7675.8 7836.1 7867.8 406.9 438.8 480.7 484.1 496.2 3309.9 3345.2 3377.3 3536.0 3588.2 49782.8 51555.5 51686.0 51698.2 51702.5 46021.8 46039.3 46391.8 46433.8 46544.0 39891.6 40102.4 40331.6 41163.0 41371.4 6866.3 6916.8 6967.9 6980.8 6995.5 30994.4 31321.8 32240.4 32289.4 32932.7 37662.4 39912.6 40177.6 40944.6 41115.0 9054.2 9068.4 9127.7 9161.0 9218.2 9686.9 9742.0 9778.5 9865.3 10048.8 9077.7 9197.2 9210.4 9237.9 9388.7 9125.1 9155.2 9188.2 9202.5 9206.7 9071.3 9161.6 9228.1 9345.3 9384.2 8121.8 8231.8 8294.2 8342.3 8462.2 8250.1 8739.0 8915.6 9007.1 9041.4 12:38:57 INFO - PROCESS | 7679 | -------- Summary: end -------- 12:38:57 INFO - PROCESS | 7679 | 12:38:58 INFO - TEST-INFO | 7679: exit 0 12:38:58 INFO - TEST-OK | dromaeo_css | took 1116148ms 12:38:58 INFO - TEST-START | kraken 12:38:58 INFO - operating with platform_type : linux_ 12:38:58 INFO - Initialising browser for kraken test... 12:38:58 INFO - TEST-INFO | started process 7857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoNmexP/profile http://localhost:52144/getInfo.html) 12:39:02 INFO - PROCESS | 7857 | __metrics Screen width/height:1600/1200 12:39:02 INFO - PROCESS | 7857 | colorDepth:24 12:39:02 INFO - PROCESS | 7857 | Browser inner width/height: 1024/697 12:39:02 INFO - PROCESS | 7857 | __metrics 12:39:03 ERROR - PROCESS | 7857 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:39:04 INFO - TEST-INFO | 7857: exit 0 12:39:04 INFO - Browser initialized. 12:39:04 INFO - Running cycle 1/1 for kraken test... 12:39:04 INFO - TEST-INFO | started process 7937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoNmexP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:16 INFO - PROCESS | 7937 | RSS: Main: 155086848 12:39:16 INFO - PROCESS | 7937 | 12:39:18 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52144/tests/kraken/driver.html?testName=audio-beat-detection) 12:39:19 INFO - PROCESS | 7937 | RSS: Main: 195760128 12:39:19 INFO - PROCESS | 7937 | 12:39:22 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52144/tests/kraken/driver.html?testName=audio-dft) 12:39:22 INFO - PROCESS | 7937 | RSS: Main: 184516608 12:39:22 INFO - PROCESS | 7937 | 12:39:25 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52144/tests/kraken/driver.html?testName=audio-fft) 12:39:26 INFO - PROCESS | 7937 | RSS: Main: 170332160 12:39:26 INFO - PROCESS | 7937 | 12:39:28 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52144/tests/kraken/driver.html?testName=audio-oscillator) 12:39:29 INFO - PROCESS | 7937 | RSS: Main: 172834816 12:39:29 INFO - PROCESS | 7937 | 12:39:31 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52144/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:39:31 INFO - PROCESS | 7937 | RSS: Main: 173850624 12:39:31 INFO - PROCESS | 7937 | 12:39:35 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52144/tests/kraken/driver.html?testName=imaging-darkroom) 12:39:35 INFO - PROCESS | 7937 | RSS: Main: 175755264 12:39:35 INFO - PROCESS | 7937 | 12:39:39 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52144/tests/kraken/driver.html?testName=imaging-desaturate) 12:39:39 INFO - PROCESS | 7937 | RSS: Main: 177254400 12:39:39 INFO - PROCESS | 7937 | 12:39:42 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52144/tests/kraken/driver.html?testName=json-parse-financial) 12:39:43 INFO - PROCESS | 7937 | RSS: Main: 176492544 12:39:43 INFO - PROCESS | 7937 | 12:39:44 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52144/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:39:45 INFO - PROCESS | 7937 | RSS: Main: 184840192 12:39:45 INFO - PROCESS | 7937 | 12:39:47 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52144/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:39:47 INFO - PROCESS | 7937 | RSS: Main: 183160832 12:39:47 INFO - PROCESS | 7937 | 12:39:49 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52144/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:39:50 INFO - PROCESS | 7937 | RSS: Main: 190545920 12:39:50 INFO - PROCESS | 7937 | 12:39:53 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:39:53 INFO - PROCESS | 7937 | RSS: Main: 196841472 12:39:53 INFO - PROCESS | 7937 | 12:39:56 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:39:56 INFO - PROCESS | 7937 | RSS: Main: 194605056 12:39:56 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | Cycle 1(1): loaded http://localhost:52144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52144/tests/kraken/driver.html?testName=ai-astar) 12:39:58 INFO - PROCESS | 7937 | RSS: Main: 255094784 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | __start_tp_report 12:39:58 INFO - PROCESS | 7937 | _x_x_mozilla_page_load 12:39:58 INFO - PROCESS | 7937 | _x_x_mozilla_page_load_details 12:39:58 INFO - PROCESS | 7937 | |i|pagename|runs| 12:39:58 INFO - PROCESS | 7937 | |0;ai-astar;112;113;108;113;115;113;101;111;113;112 12:39:58 INFO - PROCESS | 7937 | |1;audio-beat-detection;153;130;151;176;132;155;163;131;183;131 12:39:58 INFO - PROCESS | 7937 | |2;audio-dft;162;162;161;160;162;162;163;162;162;161 12:39:58 INFO - PROCESS | 7937 | |3;audio-fft;74;76;104;97;72;76;74;126;96;78 12:39:58 INFO - PROCESS | 7937 | |4;audio-oscillator;95;96;138;94;94;94;132;94;94;139 12:39:58 INFO - PROCESS | 7937 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 12:39:58 INFO - PROCESS | 7937 | |6;imaging-darkroom;147;148;146;148;146;147;147;149;146;146 12:39:58 INFO - PROCESS | 7937 | |7;imaging-desaturate;95;96;96;96;95;95;95;97;95;95 12:39:58 INFO - PROCESS | 7937 | |8;json-parse-financial;69;67;67;66;66;67;66;80;63;65 12:39:58 INFO - PROCESS | 7937 | |9;json-stringify-tinderbox;65;64;63;64;64;64;64;64;64;65 12:39:58 INFO - PROCESS | 7937 | |10;stanford-crypto-aes;81;87;82;81;81;82;81;80;82;82 12:39:58 INFO - PROCESS | 7937 | |11;stanford-crypto-ccm;118;122;114;122;116;122;115;123;117;117 12:39:58 INFO - PROCESS | 7937 | |12;stanford-crypto-pbkdf2;151;135;144;141;144;132;141;154;143;143 12:39:58 INFO - PROCESS | 7937 | |13;stanford-crypto-sha256-iterative;66;66;67;67;65;65;66;67;68;66 12:39:58 INFO - PROCESS | 7937 | __end_tp_report 12:39:58 INFO - PROCESS | 7937 | __start_cc_report 12:39:58 INFO - PROCESS | 7937 | _x_x_mozilla_cycle_collect,1131 12:39:58 INFO - PROCESS | 7937 | __end_cc_report 12:39:58 INFO - PROCESS | 7937 | __startTimestamp1458157198757__endTimestamp 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | ------- Summary: start ------- 12:39:58 INFO - PROCESS | 7937 | Number of tests: 14 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:3.98 (3.5%) stddev-sans-first:4.21 12:39:58 INFO - PROCESS | 7937 | Values: 112.0 113.0 108.0 113.0 115.0 113.0 101.0 111.0 113.0 112.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:154.00 stddev:19.47 (12.6%) stddev-sans-first:20.63 12:39:58 INFO - PROCESS | 7937 | Values: 153.0 130.0 151.0 176.0 132.0 155.0 163.0 131.0 183.0 131.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 12:39:58 INFO - PROCESS | 7937 | Values: 162.0 162.0 161.0 160.0 162.0 162.0 163.0 162.0 162.0 161.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#3] audio-fft Cycles:10 Average:87.30 Median:76.00 stddev:17.88 (23.5%) stddev-sans-first:18.30 12:39:58 INFO - PROCESS | 7937 | Values: 74.0 76.0 104.0 97.0 72.0 76.0 74.0 126.0 96.0 78.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:94.00 stddev:20.33 (21.6%) stddev-sans-first:21.10 12:39:58 INFO - PROCESS | 7937 | Values: 95.0 96.0 138.0 94.0 94.0 94.0 132.0 94.0 94.0 139.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:39:58 INFO - PROCESS | 7937 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 12:39:58 INFO - PROCESS | 7937 | Values: 147.0 148.0 146.0 148.0 146.0 147.0 147.0 149.0 146.0 146.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 12:39:58 INFO - PROCESS | 7937 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 95.0 97.0 95.0 95.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:67.00 stddev:4.62 (6.9%) stddev-sans-first:4.88 12:39:58 INFO - PROCESS | 7937 | Values: 69.0 67.0 67.0 66.0 66.0 67.0 66.0 80.0 63.0 65.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 12:39:58 INFO - PROCESS | 7937 | Values: 65.0 64.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:1.91 (2.3%) stddev-sans-first:2.00 12:39:58 INFO - PROCESS | 7937 | Values: 81.0 87.0 82.0 81.0 81.0 82.0 81.0 80.0 82.0 82.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:120.00 stddev:3.34 (2.8%) stddev-sans-first:3.54 12:39:58 INFO - PROCESS | 7937 | Values: 118.0 122.0 114.0 122.0 116.0 122.0 115.0 123.0 117.0 117.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:143.50 stddev:6.49 (4.5%) stddev-sans-first:6.17 12:39:58 INFO - PROCESS | 7937 | Values: 151.0 135.0 144.0 141.0 144.0 132.0 141.0 154.0 143.0 143.0 12:39:58 INFO - PROCESS | 7937 | 12:39:58 INFO - PROCESS | 7937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 12:39:58 INFO - PROCESS | 7937 | Values: 66.0 66.0 67.0 67.0 65.0 65.0 66.0 67.0 68.0 66.0 12:39:58 INFO - PROCESS | 7937 | -------- Summary: end -------- 12:39:58 INFO - PROCESS | 7937 | 12:39:59 INFO - TEST-INFO | 7937: exit 0 12:39:59 INFO - TEST-OK | kraken | took 61173ms 12:39:59 INFO - SUITE-END | took 1177s 12:39:59 INFO - Completed test suite (00:19:37) 12:39:59 INFO - javascript benchmark 12:39:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2593.4164812917093, 2686.8790904409325, 2688.7311268873113, 2692.08469120499, 2710.8373497590146, 4489.955100449003, 4564.520725323843, 4594.517575654559, 4596.517365676606, 4621.930671039937, 4655.348251244828, 4700.247960326348, 4710.105080034791, 4713.811447542094, 4770.713757174572, 4280.122574872159, 4304.24675681756, 4306.0, 4325.351197320396, 4429.202743506184, 4245.23585754564, 4356.760378179199, 4357.346398040288, 4399.318105693623, 4408.5591440855815, 4253.468316460442, 4306.97846510767, 4370.366296886966, 4371.759553224571, 4397.692161548693, 4264.722793018444, 4276.208901353229, 4281.379200016011, 4286.657067434598, 4320.092780516095, 4266.57334266574, 4271.1671224111, 4277.251480990814, 4299.376590394375, 4331.436913201295, 4484.439445069366, 4598.402207713009, 4659.487456379796, 4668.696534725266, 4679.578837904571, 4972.229304457815, 4999.975000125012, 5000.47495013022, 5003.699778013331, 5044.268581055763, 5039.77321020555, 5044.697318160922, 5046.5710414614805, 5047.570956468705, 5083.923741143886, 4586.633069354477, 4691.554302341272, 4717.528247175255, 4755.881102972384, 4768.7615619218905, 5135.204043373283, 5157.561607263425, 5165.48345165488, 5166.689998600021, 5170.45710200431, 4818.518148185223, 4932.876678083005, 4933.802647894116, 4947.307376967227, 4982.750862456863, 5005.974970125126, 5021.372328458942, 5050.6464547482055, 5070.0, 5079.212722028092, 4948.035133149001, 4949.57928576075, 4954.677945933503, 4956.975215123901, 4995.9500404996215, 4835.105505481497, 4918.0901533216465, 4930.112579735682, 4932.1122198004705, 4983.25251212321, 3879.2629400414394, 3895.02624343914, 3936.9015774605864, 3945.92108157841, 3947.3289540777564, 3499.4245346668094, 3500.1949551603275, 3510.613832478425, 3515.6308587598446, 3541.610422853484, 4238.449001629769, 4362.716423432466, 4364.388985542027, 4365.978170109192, 4397.6921615487245, 4954.380702412199, 4965.1807451770055, 4981.37732783402, 5025.84922452327, 5027.296178535008, 4252.29837076885, 4258.276093064186, 4259.446271984622, 4293.6779741518885, 4301.741895486281, 4408.0, 4429.645628349725, 4448.088141930896, 4456.398386217819, 4536.6143877770755, 4787.497312782108, 4791.233402655558, 4792.472827988988, 4802.351682522884, 4843.297721830315, 5040.395152581714, 5044.470330615232, 5046.571041461517, 5047.722375269395, 5059.974700126476, 4587.082583483383, 4727.030958653399, 4771.403574553181, 4818.4217893852965, 4830.2513110467935, 4897.534734200245, 4917.877053073702, 4918.163912135017, 4923.187674033744, 4963.0, 4931.753412329297, 4991.176455884738, 4997.350344455198, 5005.974970125126, 5036.521530454601, 4729.668923175483, 4863.270509423473, 4874.926876096791, 4916.827911023097, 4922.015596880567, 4819.7108173509705, 4821.397325334333, 4831.202851529459, 4839.0, 4898.142825005681, 4741.407324084489, 4765.547273009059, 4772.570468657837, 4782.473927868002, 4818.6626936114135, 4754.619630429626, 4804.279358096313, 4878.365812444502, 4879.487653796442, 4964.925526117039, 4716.457607375059, 4752.596029337545, 4804.735739534359, 4857.0, 4857.95142048575], "unit": "score", "name": "dojo.html", "value": 4576.484910480692}, {"lowerIsBetter": false, "replicates": [519.9948000519994, 543.2421771628581, 546.7184400033982, 564.5652847307574, 574.052812858783, 28405.85797071014, 35954.2809143817, 36537.08657283566, 36549.81725091371, 36708.082297942565, 39233.803830980876, 39687.61874287545, 39746.205075898535, 39788.0, 39840.80079599605, 7725.5364678119495, 7911.683532658687, 7924.0, 7924.088729796061, 7934.44458887878, 7727.227277272284, 7854.3716502679645, 7854.921450785476, 7855.764327070197, 8041.437099403044, 8006.23940725633, 8075.152109028556, 8082.07056188537, 8082.959585202066, 8088.514689118642, 7950.642221100035, 8010.198980101973, 8017.238362355567, 8020.0375954885785, 8023.919760802376, 7879.290863822283, 7994.760157195294, 8011.639476223584, 8012.479188852706, 8015.839683206304, 38302.23395532102, 38707.612923870685, 38721.61278387236, 38775.0, 38809.417858732144, 3239.3683231769814, 3264.396086723964, 3266.657001014883, 3294.7199488043543, 3531.4349704047486, 27824.721752782414, 28078.859605702044, 28365.290867728265, 28899.855500722573, 28935.42129157405, 3421.4525675891737, 3425.657434256579, 3429.5884493860895, 3446.4485682290715, 3568.5360903082433, 250298.0, 252424.0, 252892.0, 253142.0, 253275.73362133256, 43371.78314108472, 43935.56064439379, 56444.71777641168, 57551.13673294904, 57685.71157144271, 41881.37177942333, 42069.0, 42119.57880421218, 42139.0, 42140.0, 12971.870281297255, 13121.67195820093, 13137.60587182386, 13198.47206111764, 13222.074454788073, 10260.0, 10379.169666426667, 10391.896081039244, 10398.324108932895, 10400.58397664085, 14733.705325893636, 14737.778933316009, 14765.33555989983, 14801.629959251104, 14891.404343826342, 5810.970945145332, 5925.111233314951, 5935.169076329317, 5992.58051936369, 5992.730327135289, 912.2246090822748, 912.9132732390412, 935.2144198872979, 964.8938616752151, 1006.6023920551341, 27310.5903411449, 27723.752431140245, 27742.44515109727, 27915.0, 28230.0, 1002.8395456726888, 1004.6684594083935, 1006.3961623026125, 1013.1540163963173, 1022.2384323678907, 14179.85820141806, 14549.34527946245, 14662.853371466363, 14854.2572871356, 14893.851061489464, 302332.0, 697690.0, 709436.0, 712449.0, 715724.0, 51120.744396278526, 51508.484915151115, 51862.222066669034, 51897.48102519002, 51957.740211298704, 1119.5633702855894, 1206.0, 1233.993830030862, 1265.6076616248993, 1279.5201799325253, 25545.744542554337, 27602.861985689942, 29125.563116553694, 29370.41259174762, 29983.4003319928, 39276.2144757109, 39469.60530394659, 39752.60247397605, 39871.80064099661, 39945.60054399419, 230638.0, 232164.0, 232292.0, 232622.0, 234805.0, 26603.33491662724, 30640.84679576588, 31428.685713142575, 31551.21121971877, 31618.209544761565, 34423.0, 36369.0, 39368.10978695463, 39644.801775990934, 40108.99727506836, 33919.491207632396, 34126.0, 34287.14282142966, 34469.482957756154, 35365.0, 34234.65765342315, 34356.14109647279, 34679.65320346764, 34773.0, 35206.29587408289, 33843.0, 33951.66048339485, 34113.48829767506, 34169.0, 34590.82704586461, 28941.56587651145, 31084.22289442782, 31132.22169445782, 31136.457756422406, 31173.220669483446, 23650.88174559185, 23875.522489550458, 23954.28137155888, 24047.51904961926, 24199.63700544458], "unit": "score", "name": "ext.html", "value": 17165.234306160193}, {"lowerIsBetter": false, "replicates": [338.03322497656706, 353.82662495377275, 357.93736096183176, 359.96940260077895, 365.398918778609, 15627.609309767262, 16134.193290335481, 16306.510804675863, 16940.66118677626, 16941.407050753227, 9543.618255269781, 9743.366681165737, 10881.347119172855, 15196.772048419283, 15207.84792152078, 4619.3071039344195, 4769.713817170964, 4770.165221086313, 4773.546513081252, 4794.736289504076, 3462.6191118976894, 4749.453812811519, 6014.188084608588, 6026.126211699301, 6028.63828170309, 5936.732847021873, 5942.821715348547, 5948.702564871739, 5969.13447550105, 5971.0744834550715, 5737.7991770288045, 5914.0, 5946.821595352147, 5965.075413310944, 5966.40335966402, 5242.370915490127, 5255.0, 5280.709560974145, 5289.550388217006, 5307.628466007381, 15733.977291476018, 18899.244030238773, 19989.500787440855, 19991.80008199914, 20014.79985200144, 2007.7490313710787, 2043.8978051097533, 2184.2791878680155, 2494.077191439161, 2544.7328030556896, 9014.323925705598, 9068.77328066797, 9332.253419726405, 9375.718728438158, 9560.521973901277, 1787.0796539782023, 1794.9371771988049, 1821.5537193387704, 1830.094103418803, 1842.4656849513624, 60586.45601579899, 60846.69576652133, 61516.38483615196, 61616.0, 61625.0, 10290.434026128634, 10301.74245643865, 10395.116415104801, 10396.116330112025, 10541.947290263499, 13365.33173341329, 13518.864811351761, 13541.66145846342, 13541.661458463617, 13555.864441355658, 7003.54476958996, 7199.964000180071, 7255.536252720689, 7342.375898048619, 7353.154387245429, 6887.690053947585, 6893.241743408221, 6911.965440172868, 6915.135608048994, 6993.160820701549, 4395.318725597537, 4397.1865204937185, 4398.824047038082, 4467.664925130628, 4526.207913615104, 1806.9638607227782, 1836.173721825184, 1842.640685066399, 1861.1066687989842, 1882.585831117152, 874.501534125555, 887.2990337633327, 916.4272329793879, 975.0882924465506, 1012.3925644613321, 15893.920530397274, 16495.587610309838, 16506.917465412596, 16556.66886662284, 16611.83388166127, 872.7818045488627, 885.6059053721033, 895.3195571365809, 941.6986564299358, 949.539473355422, 9007.414518056305, 9263.25893928484, 9424.670136545188, 9585.424874507551, 9702.951485242529, 420258.0, 427622.0, 427817.0, 428069.0, 435888.6672366286, 54627.0, 64362.0, 64464.355356445834, 69355.49189302679, 72839.2716072843, 898.4968417686117, 898.8427025270552, 926.2493886554417, 926.6200857648332, 938.0291398402757, 14163.36264868104, 14492.565223043326, 14554.85445145535, 14674.926625366805, 14849.0, 31398.372032558764, 31802.204944876565, 32088.358232834744, 32463.0, 32554.186145345608, 48174.0, 48234.27648585344, 48314.0, 48344.274835876786, 48351.75824120857, 7560.206178351194, 7561.697532098655, 7566.583837888969, 7576.772696819105, 7638.350740187147, 7208.819779505554, 9817.7727784027, 9961.452120133463, 11558.826617600911, 11744.236624619372, 8680.435771674822, 9372.578233979351, 9529.094736000068, 9715.854262186214, 10043.246756493147, 10002.24983126254, 10122.8481572775, 10289.794204116026, 10337.328073675488, 10352.275340726379, 8713.25937295337, 9986.201103911815, 10187.949060254949, 10252.179825613784, 10252.333598316085, 7111.928880711127, 7453.701851925862, 7496.550206987598, 7611.695532178873, 7743.148253692202, 9769.267304952014, 10135.54390052464, 10325.32885362449, 10448.850626430934, 10549.419781911762], "unit": "score", "name": "jquery.html", "value": 8016.366455924041}, {"lowerIsBetter": false, "replicates": [1270.6696258972665, 1415.76639854424, 1422.1609250542178, 1570.3169121432177, 1782.171290349987, 6962.16454025517, 7100.644967751605, 7107.6090815005155, 7144.321289477498, 7148.213696493388, 7043.542169758962, 7182.461315401352, 7202.747903823354, 7227.0, 7251.927480725191, 1918.194358369488, 1966.0857701168954, 2138.7326584176976, 2239.8208143348493, 2265.7507674155913, 2212.977870221301, 2220.7668194839553, 2222.7888350606668, 2223.2440970070174, 2223.655333423322, 2140.357892632212, 2159.74083110027, 2170.0560256288486, 2256.244158207003, 2258.4579700871755, 2193.6599827026835, 2212.977870221301, 2220.766819483947, 2221.655643375271, 2223.0774228695072, 2238.23899874042, 2264.6036943534814, 2264.7395549511853, 2267.2971378872603, 2271.5911135995516, 7197.676104575306, 7272.090988626422, 7277.3814225790875, 7289.307515785992, 7292.307230813064, 4429.313456414261, 4487.102579484116, 4534.433195850519, 4537.38745269391, 4540.795664195086, 2859.9428011439863, 2883.0774152271283, 2983.8358890261243, 2990.1627544287635, 3009.8043627164384, 943.8018016216603, 944.3200895355333, 966.120830044663, 967.400211868639, 981.3375971219398, 9974.451405172713, 10007.49962501872, 10019.148372388356, 10047.196224302039, 10050.64822731201, 4210.936835947463, 4247.086876321544, 4308.4399028126145, 4308.870733877989, 4342.174986752507, 8507.787305317293, 8531.488110713377, 8568.657253709782, 8570.057293697688, 8600.354973377021, 4531.093781243764, 4536.61438777701, 4538.29656403258, 4538.841140560065, 4540.727556346564, 3547.6629720176543, 3599.352116618981, 3626.165981824195, 3633.8909832705062, 4086.264472394938, 3461.2904354607244, 3528.576570811519, 3581.606023337431, 3651.94522082169, 3653.159773252167, 1196.174639498743, 1215.975680486403, 1218.792805223114, 1225.136278923357, 1229.3361584744139, 934.9532523373804, 961.4808003678075, 962.0139357158968, 1006.4716024087267, 1219.896308813743, 7022.789316320519, 7024.754133605402, 7040.119985001875, 7063.646817659199, 7066.0, 1042.7080417483116, 1061.5117046158698, 1065.3714308557987, 1090.9890901091046, 1092.8032954068185, 5348.064088784447, 5387.838364849061, 5396.622236443412, 5440.619156658996, 5447.618666693294, 8512.787180320418, 8612.8708069379, 8615.095414981337, 8626.913730862736, 8712.564371781385, 8444.45111067791, 8501.914980850235, 8534.231919127309, 8540.188682075193, 8560.186782255676, 6646.767363142267, 6702.19573651165, 6802.659867006729, 6843.315668433216, 6858.794236172823, 6749.93250067493, 6759.628220447726, 6781.38967492928, 6785.5250132490255, 6957.512974091967, 7793.532388056735, 8007.679692812222, 8128.715494957648, 8132.2680958714, 8158.143394943683, 8108.675652973815, 8231.053428855519, 8365.790855228424, 8377.204165604258, 8391.244787969112, 5480.945190548044, 5949.940500594938, 6117.449429551361, 6176.845578860564, 6302.243730752339, 6897.7240910363025, 6930.0, 6946.305369463013, 6955.756548520778, 6966.756163534252, 5966.820995370146, 6171.691415429121, 6229.875402492015, 6250.281217660027, 6379.457746091449, 6129.3564175762685, 6215.316315205414, 6252.468540173954, 6283.214598175228, 6334.92306307938, 6397.232332120176, 6591.868162636624, 6592.901106483502, 6593.044008618819, 6607.603543787388, 5990.64056156632, 6054.54590905675, 6058.151858739692, 6067.211262535842, 6069.787557435468, 6067.089936509382, 6239.5008399327035, 6240.4071613196675, 6240.500759939103, 6253.78111766086], "unit": "score", "name": "mootools.html", "value": 4232.6943826577735}, {"lowerIsBetter": false, "replicates": [320.82515029309053, 323.24683487474186, 324.44681817501146, 327.2440662070616, 330.20585491892, 5374.140137577989, 5489.149181876811, 5498.4501549845, 5522.944770552298, 5529.751161197746, 5379.0, 5400.729963501819, 5412.296401467804, 5426.240326354314, 5439.809606663767, 4018.8191531381012, 4134.8139333729905, 4188.0, 4205.831766729335, 4236.597523235288, 4226.936595951063, 4227.87316380509, 4228.386883901832, 4237.6186143247105, 4239.364095385686, 4188.97905510472, 4192.909843440712, 4198.643115335185, 4199.202151591188, 4204.789760511978, 4004.479417675698, 4091.0999580092334, 4164.9583504164875, 4165.58344165584, 4179.561146079648, 3671.2473942841652, 3673.963260367389, 3674.6141655126094, 3682.8710995115043, 3683.37382644951, 5208.088584497736, 5210.531052205281, 5211.140161873324, 5213.087709650796, 5214.400343960455, 4844.685095468783, 4851.126797176506, 4851.490593487703, 4856.198727210006, 4858.125537403302, 5705.144228365737, 5709.457601527848, 5709.74306156224, 5713.457221563986, 5713.571482138815, 3956.3274243378405, 4050.615191556827, 4061.2283666103344, 4063.634272915422, 4064.7764372959477, 5922.052471604566, 6012.398760123996, 6015.849603759897, 6022.939770602326, 6024.57827952048, 4145.709800313949, 4166.58334166587, 4171.144915292358, 4171.666266698657, 4175.123224122907, 4234.978825105854, 4239.258129827268, 4240.6395456385935, 4242.066745316026, 4245.936310955338, 4810.903781924412, 4814.975925120422, 4816.060868130681, 4816.446108697474, 4827.927581086286, 5730.541556675456, 5738.426157384311, 5743.827685169452, 5744.798932037359, 5747.8563035924435, 1413.046193819168, 1490.381491680962, 1498.820141583017, 1501.5045035138378, 1503.7669161280019, 910.6402970826487, 944.5324564340696, 946.1910066892708, 946.4652471353663, 982.2093214962024, 4849.684770489906, 4870.391201099863, 4911.533404326655, 4963.975180124148, 5009.524095210949, 5994.430529099728, 6000.0, 6001.279846418458, 6009.549283803733, 6022.337542870281, 5071.112555302881, 5071.46749591295, 5071.54356107952, 5077.365329333833, 5081.491850814963, 3182.98408507956, 3214.8553315100407, 3219.388316219911, 3222.85497152624, 3235.2397186661115, 5655.971720141373, 5656.660600363992, 5660.235868157828, 5660.830175094754, 5664.971675141598, 5928.110783382441, 6192.690365481708, 6196.442320191204, 6201.7519299228425, 6207.224096987877, 5647.491725744702, 5659.688717120515, 5663.745131469093, 5678.3753787084215, 5678.77284908599, 6020.458158765732, 6024.638521688713, 6027.57806953509, 6028.487578555696, 6033.12519684652, 5881.7647294107755, 5892.204552385373, 5897.5576831736935, 5899.292084949662, 5902.2622172228475, 5444.782208711766, 5667.121596152438, 5672.347680016851, 5677.886442271214, 5679.375268720355, 4027.0737730321603, 4047.372657238133, 4050.8784736457956, 4059.715819892579, 4082.0203151242895, 5971.820845374646, 5973.342932277359, 5976.462118409364, 5981.461668449861, 5984.730687119177, 5745.0, 5772.740226689725, 5778.306603207642, 5780.0, 5787.450192231731, 5767.250257466502, 5771.5671324649975, 5782.2483077199695, 5782.335031471434, 5785.797497087582, 5438.619296649196, 5640.407757185437, 5666.263385759825, 5675.489205971482, 5680.147977803363, 5811.070228763378, 5820.970895145497, 5823.767049317979, 5824.0, 5830.708464576839, 5662.971685141548, 5671.829845104653, 5686.317641883001, 5689.0, 5693.117566777156], "unit": "score", "name": "prototype.html", "value": 4317.828529902337}, {"lowerIsBetter": false, "replicates": [638.4222278837651, 685.6880119545607, 699.115618742291, 723.8552289542091, 739.6117038554761, 11606.709832254188, 11689.883101168985, 11709.473073711682, 11711.472983715721, 11720.355380454082, 11828.822567661471, 12339.938300308486, 12392.31842248676, 12450.43973021214, 12513.124081314312, 642.4057746584414, 789.5302295134386, 794.2732399854126, 805.4683908620283, 812.4150611559668, 810.0, 812.5733989655448, 814.6497006287294, 814.7189219719187, 816.5060138616141, 852.0457088061349, 854.5043874552775, 855.0252711908398, 855.3969451536683, 856.2507805670039, 667.4526887951881, 828.98342033159, 848.4951453884929, 849.4563479373206, 851.1318455175717, 619.0250355689761, 619.071392910634, 619.1084837833505, 620.0822782282203, 620.3238470067648, 11492.770144597145, 11526.0, 11536.480858361394, 11589.188756787029, 11597.362145082017, 11915.2255103418, 12282.938585307016, 12320.876791232153, 12599.874001259961, 12681.746365072648, 9782.364146330538, 9814.754631134207, 9834.557444914995, 9917.801643967081, 9933.453660048766, 3285.2772390074383, 3347.380734564089, 3349.8325083745717, 3371.881984130568, 3427.246005878703, 41761.58238417638, 42098.36852447216, 42122.78938605318, 42160.789196053825, 42310.78844605788, 9819.607215711292, 10091.192704583616, 10132.290739648153, 10217.13154381886, 10281.845772313422, 17586.47240582759, 17591.560210994572, 17857.107144642716, 17942.820571794375, 17943.371981980566, 6706.664666766642, 6819.556728812611, 6856.588604683735, 6906.723731050702, 6929.203141638776, 3748.5501739790852, 3772.490713753608, 3791.3554695701796, 3825.407061905409, 3845.8269377878064, 2572.164046684835, 2577.9355516111873, 2583.4962182374256, 2587.706146926537, 2592.546304396723, 504.07250658788007, 506.3923292049555, 513.3377942454192, 516.9431362550116, 518.0416229974592, 429.4738944792667, 530.5728888244922, 544.1429748146685, 547.8110052032042, 568.8378812038549, 7328.267173282629, 7606.695732170651, 7675.846483070419, 7836.138024817265, 7867.803304917423, 406.92268468991386, 438.8485972339538, 480.70917095156926, 484.10440684733663, 496.19616221721043, 3309.851056702454, 3345.180430794471, 3377.324535092991, 3536.0, 3588.1567831560083, 49782.75108624506, 51555.48444515582, 51686.0, 51698.22452663213, 51702.48297517052, 46021.76989115033, 46039.309410358874, 46391.768041160256, 46433.76783116063, 46544.0, 39891.60108398937, 40102.39846402306, 40331.59668403337, 41163.0, 41371.37942930858, 6866.313368663094, 6916.757913473004, 6967.8606427870145, 6980.7905762827195, 6995.545289556163, 30994.380112398077, 31321.8433907829, 32240.355192895542, 32289.35421291514, 32932.67067329296, 37662.435063474615, 39912.60087399089, 40177.59822401738, 40944.59055409408, 41115.0, 9054.185123338932, 9068.410553314014, 9127.726168214964, 9161.0, 9218.170364667212, 9686.903130968882, 9742.0, 9778.462184579916, 9865.26010549226, 10048.849267261143, 9077.727668169966, 9197.218236449977, 9210.355275130945, 9237.907620923974, 9388.67139650109, 9125.087491250822, 9155.176034156957, 9188.173064424234, 9202.493862837608, 9206.723798286062, 9071.319651026068, 9161.633534658538, 9228.123328283802, 9345.252379809735, 9384.202342800938, 8121.796955075934, 8231.753047408587, 8294.170582941657, 8342.29090527312, 8462.153784621489, 8250.051244106764, 8738.956305218688, 8915.55422228873, 9007.144321289466, 9041.367104302899], "unit": "score", "name": "yui.html", "value": 5611.23414677006}], "name": "dromaeo_css", "value": 6334.182884708062}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 108.0, 113.0, 115.0, 113.0, 101.0, 111.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [153.0, 130.0, 151.0, 176.0, 132.0, 155.0, 163.0, 131.0, 183.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 162.0, 162.0, 163.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 104.0, 97.0, 72.0, 76.0, 74.0, 126.0, 96.0, 78.0], "unit": "score", "name": "audio-fft", "value": 87.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 138.0, 94.0, 94.0, 94.0, 132.0, 94.0, 94.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 146.0, 148.0, 146.0, 147.0, 147.0, 149.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 97.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 80.0, 63.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 67.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [81.0, 87.0, 82.0, 81.0, 81.0, 82.0, 81.0, 80.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [118.0, 122.0, 114.0, 122.0, 116.0, 122.0, 115.0, 123.0, 117.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [151.0, 135.0, 144.0, 141.0, 144.0, 132.0, 141.0, 154.0, 143.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 67.0, 65.0, 65.0, 66.0, 67.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1518.2999999999997}]} 12:39:59 INFO - Return code: 0 12:40:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:40:00 ERROR - # TBPL SUCCESS # 12:40:00 INFO - Running post-action listener: _resource_record_post_action 12:40:00 INFO - Running post-run listener: _resource_record_post_run 12:40:01 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 523870208; Read time: 0; Write time: 504112 12:40:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232456192; Read time: 0; Write time: 304796 12:40:01 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 287395840; Read time: 0; Write time: 198672 12:40:01 INFO - Running post-run listener: _upload_blobber_files 12:40:01 INFO - Blob upload gear active. 12:40:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:40:01 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 12:40:01 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'] 12:40:01 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 12:40:01 INFO - (blobuploader) - INFO - Open directory for files ... 12:40:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:40:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:40:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:02 INFO - (blobuploader) - INFO - Done attempting. 12:40:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:40:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:40:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:03 INFO - (blobuploader) - INFO - Done attempting. 12:40:03 INFO - (blobuploader) - INFO - Iteration through files over. 12:40:03 INFO - Return code: 0 12:40:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:40:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:40:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc1eb73b50a8be98af9a997a12257433fc55ee44e3d049c3a6e42a7dc6e59d3f3936909177a0756002fe41ddaa3252dbb2ea7d5b3a356dea26d2b4f9b5d90359", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1afbf01a834637f1b39d6d0a4bfd998eb245b432fc93cf740acc9ac2184edc796e41d32532c989631bccdaef85597a55dd4a3a28e5cdc8f31cc3318f866c40f7"} 12:40:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:40:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:40:03 INFO - Contents: 12:40:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc1eb73b50a8be98af9a997a12257433fc55ee44e3d049c3a6e42a7dc6e59d3f3936909177a0756002fe41ddaa3252dbb2ea7d5b3a356dea26d2b4f9b5d90359", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1afbf01a834637f1b39d6d0a4bfd998eb245b432fc93cf740acc9ac2184edc796e41d32532c989631bccdaef85597a55dd4a3a28e5cdc8f31cc3318f866c40f7"} 12:40:03 INFO - Running post-run listener: copy_logs_to_upload_dir 12:40:03 INFO - Copying logs to upload dir... 12:40:03 INFO - mkdir: /builds/slave/test/build/upload/logs 12:40:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.323590 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-16 12:40:01.996993) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 12:40:02.001436) ========= 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=574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676 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/bc1eb73b50a8be98af9a997a12257433fc55ee44e3d049c3a6e42a7dc6e59d3f3936909177a0756002fe41ddaa3252dbb2ea7d5b3a356dea26d2b4f9b5d90359", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1afbf01a834637f1b39d6d0a4bfd998eb245b432fc93cf740acc9ac2184edc796e41d32532c989631bccdaef85597a55dd4a3a28e5cdc8f31cc3318f866c40f7"} build_url:https://queue.taskcluster.net/v1/task/CPI7kt6WSK2UVaWF9BlhqA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/CPI7kt6WSK2UVaWF9BlhqA/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/bc1eb73b50a8be98af9a997a12257433fc55ee44e3d049c3a6e42a7dc6e59d3f3936909177a0756002fe41ddaa3252dbb2ea7d5b3a356dea26d2b4f9b5d90359", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1afbf01a834637f1b39d6d0a4bfd998eb245b432fc93cf740acc9ac2184edc796e41d32532c989631bccdaef85597a55dd4a3a28e5cdc8f31cc3318f866c40f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 12:40:02.031938) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 12:40:02.032440) ========= 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=574dc5aafe09851ec43d388c000001b6-1458155969.289008-996035676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 12:40:02.116547) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 12:40:02.116877) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 12:40:02.117186) ========= ========= Total master_lag: 0.28 =========