builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1490096495.65 results: success (0) revision: bd4f3810b402147f8656390555b29502ce5e2644 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 04:41:35.650766) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 04:41:35.651462) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 04:41:35.651980) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 04:41:35.663845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:41:35.664160) ========= 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=df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-21 04:41:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.3M=0s 2017-03-21 04:41:36 (47.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.615516 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:41:36.294337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:41:36.294919) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015348 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:41:36.349111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-21 04:41:36.349917) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bd4f3810b402147f8656390555b29502ce5e2644 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev bd4f3810b402147f8656390555b29502ce5e2644 --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=df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-21 04:41:36,813 truncating revision to first 12 chars 2017-03-21 04:41:36,813 Setting DEBUG logging. 2017-03-21 04:41:36,813 attempt 1/10 2017-03-21 04:41:36,813 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bd4f3810b402?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 04:41:38,773 unpacking tar archive at: mozilla-central-bd4f3810b402/testing/mozharness/ program finished with exit code 0 elapsedTime=2.334796 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-21 04:41:38.699181) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 04:41:38.699551) ========= script_repo_revision: bd4f3810b402147f8656390555b29502ce5e2644 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 04:41:38.700034) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 04:41:38.700360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 04:41:38.711048) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-03-21 04:41:38.711370) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:41:39 INFO - MultiFileLogger online at 20170321 04:41:39 in /builds/slave/test 04:41:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:41:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:41:39 INFO - {'append_to_log': False, 04:41:39 INFO - 'base_work_dir': '/builds/slave/test', 04:41:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:41:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:41:39 INFO - 'branch': 'Firefox-Non-PGO', 04:41:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:41:39 INFO - 'config_files': ('talos/linux_config.py',), 04:41:39 INFO - 'default_actions': ('clobber', 04:41:39 INFO - 'read-buildbot-config', 04:41:39 INFO - 'download-and-extract', 04:41:39 INFO - 'populate-webroot', 04:41:39 INFO - 'create-virtualenv', 04:41:39 INFO - 'install', 04:41:39 INFO - 'run-tests'), 04:41:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:41:39 INFO - 'download_minidump_stackwalk': True, 04:41:39 INFO - 'download_symbols': 'ondemand', 04:41:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:41:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:41:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:41:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:41:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:41:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:41:39 INFO - 'gecko_profile': False, 04:41:39 INFO - 'gecko_profile_interval': 0, 04:41:39 INFO - 'installer_path': 'installer.exe', 04:41:39 INFO - 'log_level': 'info', 04:41:39 INFO - 'log_name': 'talos', 04:41:39 INFO - 'log_to_console': True, 04:41:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:41:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:41:39 INFO - 'opt_config_files': (), 04:41:39 INFO - 'pip_index': False, 04:41:39 INFO - 'suite': 'dromaeojs-e10s', 04:41:39 INFO - 'system_bits': '32', 04:41:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:41:39 INFO - 'title': 'talos-linux64-ix-021', 04:41:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:41:39 INFO - 'use_talos_json': True, 04:41:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:41:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:41:39 INFO - 'work_dir': 'build'} 04:41:39 INFO - [mozharness: 2017-03-21 11:41:39.275403Z] Running clobber step. 04:41:39 INFO - Running pre-action listener: _resource_record_pre_action 04:41:39 INFO - Running main action method: clobber 04:41:39 INFO - rmtree: /builds/slave/test/build 04:41:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:41:40 INFO - Running post-action listener: _resource_record_post_action 04:41:40 INFO - [mozharness: 2017-03-21 11:41:40.217931Z] Finished clobber step (success) 04:41:40 INFO - [mozharness: 2017-03-21 11:41:40.218031Z] Running read-buildbot-config step. 04:41:40 INFO - Running pre-action listener: _resource_record_pre_action 04:41:40 INFO - Running main action method: read_buildbot_config 04:41:40 INFO - Using buildbot properties: 04:41:40 INFO - { 04:41:40 INFO - "project": "", 04:41:40 INFO - "product": "firefox", 04:41:40 INFO - "who": "cbook@mozilla.com", 04:41:40 INFO - "installer_path": "public/build/target.tar.bz2", 04:41:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:41:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:41:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:41:40 INFO - "stage_platform": "linux64", 04:41:40 INFO - "basedir": "/builds/slave/test", 04:41:40 INFO - "buildnumber": 477, 04:41:40 INFO - "platform": "ubuntu64_hw", 04:41:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:41:40 INFO - "slavebuilddir": "test", 04:41:40 INFO - "taskId": "Q-nls-aVRqmTae-kG3WuCA", 04:41:40 INFO - "branch": "mozilla-central", 04:41:40 INFO - "script_repo_revision": "production", 04:41:40 INFO - "revision": "bd4f3810b402147f8656390555b29502ce5e2644", 04:41:40 INFO - "slavename": "talos-linux64-ix-021", 04:41:40 INFO - "repo_path": "mozilla-central" 04:41:40 INFO - } 04:41:40 INFO - Finding installer, test and symbols from parent task. 04:41:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q-nls-aVRqmTae-kG3WuCA'}, attempt #1 04:41:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q-nls-aVRqmTae-kG3WuCA'}, attempt #1 04:41:42 INFO - Task dependencies: I_vxfnIMQB-pm-wi5cde3w 04:41:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w'}, attempt #1 04:41:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.tar.bz2 04:41:44 INFO - Set test_url: https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/test_packages.json 04:41:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.crashreporter-symbols.zip 04:41:44 INFO - Running post-action listener: _resource_record_post_action 04:41:44 INFO - [mozharness: 2017-03-21 11:41:44.006899Z] Finished read-buildbot-config step (success) 04:41:44 INFO - [mozharness: 2017-03-21 11:41:44.007120Z] Running download-and-extract step. 04:41:44 INFO - Running pre-action listener: _resource_record_pre_action 04:41:44 INFO - Running main action method: download_and_extract 04:41:44 INFO - mkdir: /builds/slave/test/build/tests 04:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:44 INFO - trying https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.test_packages.json 04:41:44 INFO - Downloading https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:41:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:41:46 INFO - Downloaded 986 bytes. 04:41:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:41:46 INFO - Using the following test package requirements: 04:41:46 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:41:46 INFO - u'common': [u'target.common.tests.zip'], 04:41:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:41:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:41:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:41:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:41:46 INFO - u'mozbase': [u'target.common.tests.zip'], 04:41:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:41:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:41:46 INFO - u'web-platform': [u'target.common.tests.zip', 04:41:46 INFO - u'target.web-platform.tests.zip'], 04:41:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:41:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:41:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.common.tests.zip 04:41:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:41:46 INFO - Fetch https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.common.tests.zip into memory 04:41:48 INFO - Expected file size: 58196984 04:41:48 INFO - Obtained file size: 58196984 04:41:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:41:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.common.tests.zip 04:41:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:41:58 INFO - Fetch https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.common.tests.zip into memory 04:42:00 INFO - Expected file size: 58196984 04:42:00 INFO - Obtained file size: 58196984 04:42:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.talos.tests.zip 04:42:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:42:11 INFO - Fetch https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.talos.tests.zip into memory 04:42:12 INFO - Expected file size: 14404171 04:42:12 INFO - Obtained file size: 14404171 04:42:12 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:12 INFO - trying https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.tar.bz2 04:42:12 INFO - Downloading https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:42:14 INFO - Downloaded 61903439 bytes. 04:42:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.tar.bz2 04:42:14 INFO - mkdir: /builds/slave/test/properties 04:42:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:14 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:14 INFO - Contents: 04:42:14 INFO - build_url:https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.tar.bz2 04:42:14 INFO - Running post-action listener: _resource_record_post_action 04:42:14 INFO - Running post-action listener: set_extra_try_arguments 04:42:14 INFO - [mozharness: 2017-03-21 11:42:14.231173Z] Finished download-and-extract step (success) 04:42:14 INFO - [mozharness: 2017-03-21 11:42:14.231271Z] Running populate-webroot step. 04:42:14 INFO - Running pre-action listener: _resource_record_pre_action 04:42:14 INFO - Running main action method: populate_webroot 04:42:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:14 INFO - '--tppagecycles', 04:42:14 INFO - '7'], 04:42:14 INFO - 'tests': ['tsvgm']}}, 04:42:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:42:14 INFO - 'talos_options': ['--disable-e10s'], 04:42:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:42:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:42:14 INFO - 'talos_options': ['--disable-e10s'], 04:42:14 INFO - 'tests': ['damp', 'tps']}, 04:42:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:42:14 INFO - 'tests': ['damp', 'tps']}, 04:42:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:14 INFO - 'tests': ['dromaeo_dom']}, 04:42:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:42:14 INFO - 'tests': ['basic_compositor_video']}, 04:42:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:42:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:14 INFO - 'tests': ['a11yr', 04:42:14 INFO - 'ts_paint', 04:42:14 INFO - 'tpaint', 04:42:14 INFO - 'sessionrestore', 04:42:14 INFO - 'sessionrestore_no_auto_restore', 04:42:14 INFO - 'tabpaint']}, 04:42:14 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:14 INFO - 'ts_paint', 04:42:14 INFO - 'tpaint', 04:42:14 INFO - 'sessionrestore', 04:42:14 INFO - 'sessionrestore_no_auto_restore', 04:42:14 INFO - 'tabpaint']}, 04:42:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:14 INFO - 'ts_paint', 04:42:14 INFO - 'tpaint', 04:42:14 INFO - 'sessionrestore', 04:42:14 INFO - 'sessionrestore_no_auto_restore', 04:42:14 INFO - 'tabpaint']}, 04:42:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:14 INFO - 'ts_paint', 04:42:14 INFO - 'tpaint', 04:42:14 INFO - 'sessionrestore', 04:42:14 INFO - 'sessionrestore_no_auto_restore', 04:42:14 INFO - 'tabpaint']}, 04:42:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:14 INFO - 'tests': ['a11yr', 04:42:14 INFO - 'ts_paint', 04:42:14 INFO - 'tpaint', 04:42:14 INFO - 'sessionrestore', 04:42:14 INFO - 'sessionrestore_no_auto_restore', 04:42:14 INFO - 'tabpaint']}, 04:42:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:14 INFO - 'tests': ['a11yr', 04:42:14 INFO - 'ts_paint', 04:42:14 INFO - 'tpaint', 04:42:14 INFO - 'sessionrestore', 04:42:14 INFO - 'sessionrestore_no_auto_restore', 04:42:14 INFO - 'tabpaint']}, 04:42:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:14 INFO - 'tests': ['tsvgx', 04:42:14 INFO - 'tsvgr_opacity', 04:42:14 INFO - 'tart', 04:42:14 INFO - 'tscrollx', 04:42:14 INFO - 'cart', 04:42:14 INFO - 'tsvg_static']}, 04:42:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:14 INFO - 'tsvgr_opacity', 04:42:14 INFO - 'tart', 04:42:14 INFO - 'tscrollx', 04:42:14 INFO - 'cart', 04:42:14 INFO - 'tsvg_static']}, 04:42:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:42:14 INFO - 'talos_options': ['--disable-e10s'], 04:42:14 INFO - 'tests': ['tp5o']}, 04:42:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:42:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:42:14 INFO - 'talos_options': ['--disable-e10s', 04:42:14 INFO - '--xperf_path', 04:42:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:14 INFO - 'tests': ['tp5n']}, 04:42:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:42:14 INFO - 'talos_options': ['--xperf_path', 04:42:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:14 INFO - 'tests': ['tp5n']}}, 04:42:14 INFO - 'talos.zip': {'path': '', 04:42:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:14 INFO - Running post-action listener: _resource_record_post_action 04:42:14 INFO - [mozharness: 2017-03-21 11:42:14.244484Z] Finished populate-webroot step (success) 04:42:14 INFO - [mozharness: 2017-03-21 11:42:14.244574Z] Running create-virtualenv step. 04:42:14 INFO - Running pre-action listener: _resource_record_pre_action 04:42:14 INFO - Running main action method: create_virtualenv 04:42:14 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:42:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:14 INFO - Using real prefix '/usr' 04:42:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:14 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:16 INFO - Installing pip.................done. 04:42:16 INFO - Return code: 0 04:42:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:42:17 INFO - Reading from file tmpfile_stdout 04:42:17 INFO - Output received: 04:42:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:42:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:17 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 0xaae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd49290>, '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 0xd49b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4a040>, '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': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:42:17 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 04:42:17 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 04:42:17 INFO - Using env: {'DISPLAY': ':0', 04:42:17 INFO - 'HOME': '/home/cltbld', 04:42:17 INFO - 'LANG': 'en_US.UTF-8', 04:42:17 INFO - 'LANGUAGE': 'en_US:en', 04:42:17 INFO - 'LOGNAME': 'cltbld', 04:42:17 INFO - 'MAIL': '/var/mail/cltbld', 04:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:17 INFO - 'MOZ_NO_REMOTE': '1', 04:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:17 INFO - 'NO_EM_RESTART': '1', 04:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:17 INFO - 'PWD': '/builds/slave/test', 04:42:17 INFO - 'SHELL': '/bin/bash', 04:42:17 INFO - 'SHLVL': '1', 04:42:17 INFO - 'TERM': 'linux', 04:42:17 INFO - 'TMOUT': '86400', 04:42:17 INFO - 'USER': 'cltbld', 04:42:17 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 04:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:17 INFO - '_': '/tools/buildbot/bin/python'} 04:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:42:17 INFO - Cleaning up... 04:42:17 INFO - Return code: 0 04:42:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:42:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:18 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd49290>, '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 0xd49b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4a040>, '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': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:42:18 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>=3.1.1'] in /builds/slave/test/build 04:42:18 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>=3.1.1 04:42:18 INFO - Using env: {'DISPLAY': ':0', 04:42:18 INFO - 'HOME': '/home/cltbld', 04:42:18 INFO - 'LANG': 'en_US.UTF-8', 04:42:18 INFO - 'LANGUAGE': 'en_US:en', 04:42:18 INFO - 'LOGNAME': 'cltbld', 04:42:18 INFO - 'MAIL': '/var/mail/cltbld', 04:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:18 INFO - 'MOZ_NO_REMOTE': '1', 04:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:18 INFO - 'NO_EM_RESTART': '1', 04:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:18 INFO - 'PWD': '/builds/slave/test', 04:42:18 INFO - 'SHELL': '/bin/bash', 04:42:18 INFO - 'SHLVL': '1', 04:42:18 INFO - 'TERM': 'linux', 04:42:18 INFO - 'TMOUT': '86400', 04:42:18 INFO - 'USER': 'cltbld', 04:42:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 04:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:18 INFO - '_': '/tools/buildbot/bin/python'} 04:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:18 INFO - Downloading/unpacking psutil>=3.1.1 04:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:21 INFO - Installing collected packages: psutil 04:42:21 INFO - Running setup.py install for psutil 04:42:21 INFO - building 'psutil._psutil_linux' extension 04:42:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:42:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:42:22 INFO - building 'psutil._psutil_posix' extension 04:42:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:42:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:42:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:22 INFO - Successfully installed psutil 04:42:22 INFO - Cleaning up... 04:42:22 INFO - Return code: 0 04:42:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:42:22 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:22 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:22 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd49290>, '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 0xd49b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4a040>, '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': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:42:22 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.3'] in /builds/slave/test/build 04:42:22 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.3 04:42:22 INFO - Using env: {'DISPLAY': ':0', 04:42:22 INFO - 'HOME': '/home/cltbld', 04:42:22 INFO - 'LANG': 'en_US.UTF-8', 04:42:22 INFO - 'LANGUAGE': 'en_US:en', 04:42:22 INFO - 'LOGNAME': 'cltbld', 04:42:22 INFO - 'MAIL': '/var/mail/cltbld', 04:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:22 INFO - 'MOZ_NO_REMOTE': '1', 04:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:22 INFO - 'NO_EM_RESTART': '1', 04:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:22 INFO - 'PWD': '/builds/slave/test', 04:42:22 INFO - 'SHELL': '/bin/bash', 04:42:22 INFO - 'SHLVL': '1', 04:42:22 INFO - 'TERM': 'linux', 04:42:22 INFO - 'TMOUT': '86400', 04:42:22 INFO - 'USER': 'cltbld', 04:42:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 04:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:22 INFO - '_': '/tools/buildbot/bin/python'} 04:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:42:25 INFO - Installing collected packages: mozsystemmonitor 04:42:25 INFO - Running setup.py install for mozsystemmonitor 04:42:25 INFO - Successfully installed mozsystemmonitor 04:42:25 INFO - Cleaning up... 04:42:25 INFO - Return code: 0 04:42:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:42:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:26 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd49290>, '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 0xd49b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4a040>, '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': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:42:26 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==2.5.1'] in /builds/slave/test/build 04:42:26 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==2.5.1 04:42:26 INFO - Using env: {'DISPLAY': ':0', 04:42:26 INFO - 'HOME': '/home/cltbld', 04:42:26 INFO - 'LANG': 'en_US.UTF-8', 04:42:26 INFO - 'LANGUAGE': 'en_US:en', 04:42:26 INFO - 'LOGNAME': 'cltbld', 04:42:26 INFO - 'MAIL': '/var/mail/cltbld', 04:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:26 INFO - 'MOZ_NO_REMOTE': '1', 04:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:26 INFO - 'NO_EM_RESTART': '1', 04:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:26 INFO - 'PWD': '/builds/slave/test', 04:42:26 INFO - 'SHELL': '/bin/bash', 04:42:26 INFO - 'SHLVL': '1', 04:42:26 INFO - 'TERM': 'linux', 04:42:26 INFO - 'TMOUT': '86400', 04:42:26 INFO - 'USER': 'cltbld', 04:42:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 04:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:26 INFO - '_': '/tools/buildbot/bin/python'} 04:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:26 INFO - Downloading/unpacking jsonschema==2.5.1 04:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:42:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:30 INFO - Downloading functools32-3.2.3-2.tar.gz 04:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:42:30 INFO - warning: no files found matching '*.txt' 04:42:30 INFO - no previously-included directories found matching 'build' 04:42:30 INFO - no previously-included directories found matching 'dist' 04:42:30 INFO - no previously-included directories found matching '.git*' 04:42:31 INFO - Installing collected packages: jsonschema, functools32 04:42:31 INFO - Running setup.py install for functools32 04:42:31 INFO - warning: no files found matching '*.txt' 04:42:31 INFO - no previously-included directories found matching 'build' 04:42:31 INFO - no previously-included directories found matching 'dist' 04:42:31 INFO - no previously-included directories found matching '.git*' 04:42:31 INFO - Successfully installed jsonschema functools32 04:42:31 INFO - Cleaning up... 04:42:31 INFO - Return code: 0 04:42:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:42:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:31 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd49290>, '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 0xd49b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4a040>, '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': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:42:31 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:42:31 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 functools32==3.2.3-2 04:42:31 INFO - Using env: {'DISPLAY': ':0', 04:42:31 INFO - 'HOME': '/home/cltbld', 04:42:31 INFO - 'LANG': 'en_US.UTF-8', 04:42:31 INFO - 'LANGUAGE': 'en_US:en', 04:42:31 INFO - 'LOGNAME': 'cltbld', 04:42:31 INFO - 'MAIL': '/var/mail/cltbld', 04:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:31 INFO - 'MOZ_NO_REMOTE': '1', 04:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:31 INFO - 'NO_EM_RESTART': '1', 04:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:31 INFO - 'PWD': '/builds/slave/test', 04:42:31 INFO - 'SHELL': '/bin/bash', 04:42:31 INFO - 'SHLVL': '1', 04:42:31 INFO - 'TERM': 'linux', 04:42:31 INFO - 'TMOUT': '86400', 04:42:31 INFO - 'USER': 'cltbld', 04:42:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 04:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:31 INFO - '_': '/tools/buildbot/bin/python'} 04:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:42:31 INFO - Cleaning up... 04:42:31 INFO - Return code: 0 04:42:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:42:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:32 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 0xaae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd49290>, '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 0xd49b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4a040>, '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': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:42:32 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 04:42:32 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 04:42:32 INFO - Using env: {'DISPLAY': ':0', 04:42:32 INFO - 'HOME': '/home/cltbld', 04:42:32 INFO - 'LANG': 'en_US.UTF-8', 04:42:32 INFO - 'LANGUAGE': 'en_US:en', 04:42:32 INFO - 'LOGNAME': 'cltbld', 04:42:32 INFO - 'MAIL': '/var/mail/cltbld', 04:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:32 INFO - 'MOZ_NO_REMOTE': '1', 04:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:32 INFO - 'NO_EM_RESTART': '1', 04:42:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:32 INFO - 'PWD': '/builds/slave/test', 04:42:32 INFO - 'SHELL': '/bin/bash', 04:42:32 INFO - 'SHLVL': '1', 04:42:32 INFO - 'TERM': 'linux', 04:42:32 INFO - 'TMOUT': '86400', 04:42:32 INFO - 'USER': 'cltbld', 04:42:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 04:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:32 INFO - '_': '/tools/buildbot/bin/python'} 04:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:34 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:42:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:35 INFO - Downloading docopt-0.6.1.tar.gz 04:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:35 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:35 INFO - Running setup.py install for blobuploader 04:42:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:42:35 INFO - Running setup.py install for requests 04:42:35 INFO - Running setup.py install for docopt 04:42:36 INFO - Successfully installed blobuploader requests docopt 04:42:36 INFO - Cleaning up... 04:42:36 INFO - Return code: 0 04:42:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:36 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 0xaae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd49290>, '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 0xd49b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4a040>, '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': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:42:36 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 04:42:36 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 04:42:36 INFO - Using env: {'DISPLAY': ':0', 04:42:36 INFO - 'HOME': '/home/cltbld', 04:42:36 INFO - 'LANG': 'en_US.UTF-8', 04:42:36 INFO - 'LANGUAGE': 'en_US:en', 04:42:36 INFO - 'LOGNAME': 'cltbld', 04:42:36 INFO - 'MAIL': '/var/mail/cltbld', 04:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:36 INFO - 'MOZ_NO_REMOTE': '1', 04:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:36 INFO - 'NO_EM_RESTART': '1', 04:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:36 INFO - 'PWD': '/builds/slave/test', 04:42:36 INFO - 'SHELL': '/bin/bash', 04:42:36 INFO - 'SHLVL': '1', 04:42:36 INFO - 'TERM': 'linux', 04:42:36 INFO - 'TMOUT': '86400', 04:42:36 INFO - 'USER': 'cltbld', 04:42:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 04:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:36 INFO - '_': '/tools/buildbot/bin/python'} 04:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:36 INFO - Running setup.py (path:/tmp/pip-kwO7YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:36 INFO - Running setup.py (path:/tmp/pip-ZDvj1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:36 INFO - Running setup.py (path:/tmp/pip-GyZBs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:36 INFO - Running setup.py (path:/tmp/pip-MdRJv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:36 INFO - Running setup.py (path:/tmp/pip-Y61Ocl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:36 INFO - Running setup.py (path:/tmp/pip-mYYZlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:37 INFO - Running setup.py (path:/tmp/pip-J_wLYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:37 INFO - Running setup.py (path:/tmp/pip-PCQ0bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:37 INFO - Running setup.py (path:/tmp/pip-jEmYJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:37 INFO - Running setup.py (path:/tmp/pip-CZ7nJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:37 INFO - Running setup.py (path:/tmp/pip-El1vR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:37 INFO - Running setup.py (path:/tmp/pip-9IiApY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:37 INFO - Running setup.py (path:/tmp/pip-xSoa2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:37 INFO - Running setup.py (path:/tmp/pip-rNCuea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:37 INFO - Running setup.py (path:/tmp/pip-k7gWMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:37 INFO - Running setup.py (path:/tmp/pip-qxu214-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:37 INFO - Running setup.py (path:/tmp/pip-aBVqio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:42:37 INFO - Running setup.py install for manifestparser 04:42:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:42:37 INFO - Running setup.py install for mozcrash 04:42:38 INFO - Running setup.py install for mozdebug 04:42:38 INFO - Running setup.py install for mozdevice 04:42:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:42:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:42:38 INFO - Running setup.py install for mozfile 04:42:38 INFO - Running setup.py install for mozhttpd 04:42:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:42:38 INFO - Running setup.py install for mozinfo 04:42:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:42:38 INFO - Running setup.py install for mozInstall 04:42:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:42:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:42:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:42:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:42:38 INFO - Running setup.py install for mozleak 04:42:38 INFO - Running setup.py install for mozlog 04:42:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:42:38 INFO - Running setup.py install for moznetwork 04:42:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:42:38 INFO - Running setup.py install for mozprocess 04:42:39 INFO - Running setup.py install for mozprofile 04:42:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:42:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:42:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:42:39 INFO - Running setup.py install for mozrunner 04:42:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:42:39 INFO - Running setup.py install for mozscreenshot 04:42:39 INFO - Running setup.py install for moztest 04:42:39 INFO - Running setup.py install for mozversion 04:42:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:42:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:42:39 INFO - Cleaning up... 04:42:39 INFO - Return code: 0 04:42:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:39 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 0xaae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd49290>, '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 0xd49b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4a040>, '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': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:42:39 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 04:42:39 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 04:42:39 INFO - Using env: {'DISPLAY': ':0', 04:42:39 INFO - 'HOME': '/home/cltbld', 04:42:39 INFO - 'LANG': 'en_US.UTF-8', 04:42:39 INFO - 'LANGUAGE': 'en_US:en', 04:42:39 INFO - 'LOGNAME': 'cltbld', 04:42:39 INFO - 'MAIL': '/var/mail/cltbld', 04:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:39 INFO - 'MOZ_NO_REMOTE': '1', 04:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:39 INFO - 'NO_EM_RESTART': '1', 04:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:39 INFO - 'PWD': '/builds/slave/test', 04:42:39 INFO - 'SHELL': '/bin/bash', 04:42:39 INFO - 'SHLVL': '1', 04:42:39 INFO - 'TERM': 'linux', 04:42:39 INFO - 'TMOUT': '86400', 04:42:39 INFO - 'USER': 'cltbld', 04:42:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 04:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:39 INFO - '_': '/tools/buildbot/bin/python'} 04:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:40 INFO - Running setup.py (path:/tmp/pip-GGumuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:40 INFO - Running setup.py (path:/tmp/pip-wQ75Zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:40 INFO - Running setup.py (path:/tmp/pip-mfxkYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:40 INFO - Running setup.py (path:/tmp/pip-dAQVsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:40 INFO - Running setup.py (path:/tmp/pip-GAQpJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:40 INFO - Running setup.py (path:/tmp/pip-OxEpbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:40 INFO - Running setup.py (path:/tmp/pip-LuXdTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:40 INFO - Running setup.py (path:/tmp/pip-QGfSU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:40 INFO - Running setup.py (path:/tmp/pip-wpUhIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:40 INFO - Running setup.py (path:/tmp/pip-y6CO_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:40 INFO - Running setup.py (path:/tmp/pip-TIP9lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:40 INFO - Running setup.py (path:/tmp/pip-y3qw_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:41 INFO - Running setup.py (path:/tmp/pip-Jqhns5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:41 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)) 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:41 INFO - Running setup.py (path:/tmp/pip-apRs5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:41 INFO - Running setup.py (path:/tmp/pip-sVW0xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:41 INFO - Running setup.py (path:/tmp/pip-p1OLUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:41 INFO - Running setup.py (path:/tmp/pip-fzGTMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:42:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:43 INFO - Downloading blessings-1.6.tar.gz 04:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:42:43 INFO - Installing collected packages: blessings 04:42:43 INFO - Running setup.py install for blessings 04:42:43 INFO - Successfully installed blessings 04:42:43 INFO - Cleaning up... 04:42:44 INFO - Return code: 0 04:42:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:42:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:44 INFO - Reading from file tmpfile_stdout 04:42:44 INFO - Current package versions: 04:42:44 INFO - argparse == 1.2.1 04:42:44 INFO - blessings == 1.6 04:42:44 INFO - blobuploader == 1.2.4 04:42:44 INFO - docopt == 0.6.1 04:42:44 INFO - functools32 == 3.2.3-2 04:42:44 INFO - jsonschema == 2.5.1 04:42:44 INFO - manifestparser == 1.1 04:42:44 INFO - mozInstall == 1.12 04:42:44 INFO - mozcrash == 1.0 04:42:44 INFO - mozdebug == 0.1 04:42:44 INFO - mozdevice == 0.49 04:42:44 INFO - mozfile == 1.2 04:42:44 INFO - mozhttpd == 0.7 04:42:44 INFO - mozinfo == 0.9 04:42:44 INFO - mozleak == 0.1 04:42:44 INFO - mozlog == 3.4 04:42:44 INFO - moznetwork == 0.27 04:42:44 INFO - mozprocess == 0.25 04:42:44 INFO - mozprofile == 0.28 04:42:44 INFO - mozrunner == 6.13 04:42:44 INFO - mozscreenshot == 0.1 04:42:44 INFO - mozsystemmonitor == 0.3 04:42:44 INFO - moztest == 0.8 04:42:44 INFO - mozversion == 1.4 04:42:44 INFO - psutil == 3.1.1 04:42:44 INFO - requests == 1.2.3 04:42:44 INFO - wsgiref == 0.1.2 04:42:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:44 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 0xaae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd49290>, '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 0xd49b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4a040>, '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': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:42:44 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 04:42:44 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 04:42:44 INFO - Using env: {'DISPLAY': ':0', 04:42:44 INFO - 'HOME': '/home/cltbld', 04:42:44 INFO - 'LANG': 'en_US.UTF-8', 04:42:44 INFO - 'LANGUAGE': 'en_US:en', 04:42:44 INFO - 'LOGNAME': 'cltbld', 04:42:44 INFO - 'MAIL': '/var/mail/cltbld', 04:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:44 INFO - 'MOZ_NO_REMOTE': '1', 04:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:44 INFO - 'NO_EM_RESTART': '1', 04:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:44 INFO - 'PWD': '/builds/slave/test', 04:42:44 INFO - 'SHELL': '/bin/bash', 04:42:44 INFO - 'SHLVL': '1', 04:42:44 INFO - 'TERM': 'linux', 04:42:44 INFO - 'TMOUT': '86400', 04:42:44 INFO - 'USER': 'cltbld', 04:42:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 04:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:44 INFO - '_': '/tools/buildbot/bin/python'} 04:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:44 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)) 04:42:44 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)) 04:42:44 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)) 04:42:44 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)) 04:42:44 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)) 04:42:44 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)) 04:42:44 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)) 04:42:44 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)) 04:42:44 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)) 04:42:44 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)) 04:42:44 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)) 04:42:44 INFO - Cleaning up... 04:42:44 INFO - Return code: 0 04:42:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:45 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 0xaae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd49290>, '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 0xd49b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4a040>, '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': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:42:45 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 04:42:45 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 04:42:45 INFO - Using env: {'DISPLAY': ':0', 04:42:45 INFO - 'HOME': '/home/cltbld', 04:42:45 INFO - 'LANG': 'en_US.UTF-8', 04:42:45 INFO - 'LANGUAGE': 'en_US:en', 04:42:45 INFO - 'LOGNAME': 'cltbld', 04:42:45 INFO - 'MAIL': '/var/mail/cltbld', 04:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:45 INFO - 'MOZ_NO_REMOTE': '1', 04:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:45 INFO - 'NO_EM_RESTART': '1', 04:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:45 INFO - 'PWD': '/builds/slave/test', 04:42:45 INFO - 'SHELL': '/bin/bash', 04:42:45 INFO - 'SHLVL': '1', 04:42:45 INFO - 'TERM': 'linux', 04:42:45 INFO - 'TMOUT': '86400', 04:42:45 INFO - 'USER': 'cltbld', 04:42:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 04:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:45 INFO - '_': '/tools/buildbot/bin/python'} 04:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:42:45 INFO - Cleaning up... 04:42:45 INFO - Return code: 0 04:42:45 INFO - Running post-action listener: _resource_record_post_action 04:42:45 INFO - Running post-action listener: _start_resource_monitoring 04:42:45 INFO - Starting resource monitoring. 04:42:45 INFO - [mozharness: 2017-03-21 11:42:45.277971Z] Finished create-virtualenv step (success) 04:42:45 INFO - [mozharness: 2017-03-21 11:42:45.278490Z] Running install step. 04:42:45 INFO - Running pre-action listener: _resource_record_pre_action 04:42:45 INFO - Running main action method: install 04:42:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:45 INFO - Reading from file tmpfile_stdout 04:42:45 INFO - Detecting whether we're running mozinstall >=1.0... 04:42:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:42:45 INFO - Reading from file tmpfile_stdout 04:42:45 INFO - Output received: 04:42:45 INFO - Usage: mozinstall [options] installer 04:42:45 INFO - Options: 04:42:45 INFO - -h, --help show this help message and exit 04:42:45 INFO - -d DEST, --destination=DEST 04:42:45 INFO - Directory to install application into. [default: 04:42:45 INFO - "/builds/slave/test"] 04:42:45 INFO - --app=APP Application being installed. [default: firefox] 04:42:45 INFO - mkdir: /builds/slave/test/build/application 04:42:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:43:01 INFO - Reading from file tmpfile_stdout 04:43:01 INFO - Output received: 04:43:01 INFO - /builds/slave/test/build/application/firefox/firefox 04:43:01 INFO - Running post-action listener: _resource_record_post_action 04:43:01 INFO - [mozharness: 2017-03-21 11:43:01.026016Z] Finished install step (success) 04:43:01 INFO - [mozharness: 2017-03-21 11:43:01.026292Z] Running run-tests step. 04:43:01 INFO - Running pre-action listener: _resource_record_pre_action 04:43:01 INFO - Running main action method: run_tests 04:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:43:01 INFO - Python 2.7.3 04:43:01 INFO - Return code: 0 04:43:01 INFO - grabbing minidump binary from tooltool 04:43:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:01 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd49290>, '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 0xd49b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4a040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:43:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:43:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:43:01 INFO - Calling ['/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'] with output_timeout 600 04:43:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:43:01 INFO - Return code: 0 04:43:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:43:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:43:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:43:01 INFO - ENV: RUST_BACKTRACE is now 1 04:43:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:43:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:43:01 INFO - Using env: {'DISPLAY': ':0', 04:43:01 INFO - 'HOME': '/home/cltbld', 04:43:01 INFO - 'LANG': 'en_US.UTF-8', 04:43:01 INFO - 'LANGUAGE': 'en_US:en', 04:43:01 INFO - 'LOGNAME': 'cltbld', 04:43:01 INFO - 'MAIL': '/var/mail/cltbld', 04:43:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:43:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:01 INFO - 'MOZ_NO_REMOTE': '1', 04:43:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:01 INFO - 'NO_EM_RESTART': '1', 04:43:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:01 INFO - 'PWD': '/builds/slave/test', 04:43:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:43:01 INFO - 'RUST_BACKTRACE': '1', 04:43:01 INFO - 'SHELL': '/bin/bash', 04:43:01 INFO - 'SHLVL': '1', 04:43:01 INFO - 'TERM': 'linux', 04:43:01 INFO - 'TMOUT': '86400', 04:43:01 INFO - 'USER': 'cltbld', 04:43:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061', 04:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:01 INFO - '_': '/tools/buildbot/bin/python'} 04:43:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:43:01 INFO - mozversion application_buildid: 20170321110501 04:43:01 INFO - mozversion application_changeset: bd4f3810b402147f8656390555b29502ce5e2644 04:43:01 INFO - mozversion application_display_name: Nightly 04:43:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:43:01 INFO - mozversion application_name: Firefox 04:43:01 INFO - mozversion application_remotingname: firefox 04:43:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:43:01 INFO - mozversion application_vendor: Mozilla 04:43:01 INFO - mozversion application_version: 55.0a1 04:43:01 INFO - mozversion platform_buildid: 20170321110501 04:43:01 INFO - mozversion platform_changeset: bd4f3810b402147f8656390555b29502ce5e2644 04:43:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:43:01 INFO - mozversion platform_version: 55.0a1 04:43:01 INFO - using testdate: 1490096581 04:43:01 INFO - actual date: 1490096581 04:43:01 INFO - starting webserver on 'localhost:43038' 04:43:01 INFO - SUITE-START | Running 2 tests 04:43:01 INFO - TEST-START | dromaeo_css 04:43:01 INFO - operating with platform_type : linux_ 04:43:01 INFO - Initialising browser for dromaeo_css test... 04:43:01 INFO - TEST-INFO | started process 13536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbjtnaA/profile http://localhost:43038/getInfo.html) 04:43:06 INFO - PID 13536 | __metrics Screen width/height:1600/1200 04:43:06 INFO - PID 13536 | colorDepth:24 04:43:06 INFO - PID 13536 | Browser inner width/height: 1024/697 04:43:06 INFO - PID 13536 | __metrics 04:43:07 ERROR - PID 13536 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 04:43:08 INFO - TEST-INFO | 13536: exit 0 04:43:08 INFO - Browser initialized. 04:43:08 INFO - Running cycle 1/1 for dromaeo_css test... 04:43:08 INFO - TEST-INFO | started process 13666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbjtnaA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:20 INFO - PID 13666 | RSS: Main: 155267072 04:43:20 INFO - PID 13666 | 04:46:24 INFO - PID 13666 | Cycle 1(1): loaded http://localhost:43038/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43038/tests/dromaeo/cssquery-ext.html) 04:46:27 INFO - PID 13666 | RSS: Main: 167698432 04:46:27 INFO - PID 13666 | 04:48:08 INFO - PID 13666 | ************************* 04:48:08 INFO - PID 13666 | A coding exception was thrown and uncaught in a Task. 04:48:08 INFO - PID 13666 | 04:48:08 ERROR - PID 13666 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:08 INFO - PID 13666 | Full stack: 04:48:08 INFO - PID 13666 | ************************* 04:49:29 INFO - PID 13666 | Cycle 1(1): loaded http://localhost:43038/tests/dromaeo/cssquery-ext.html (next: http://localhost:43038/tests/dromaeo/cssquery-jquery.html) 04:49:30 INFO - PID 13666 | RSS: Main: 161226752 04:49:30 INFO - PID 13666 | 04:52:32 INFO - PID 13666 | Cycle 1(1): loaded http://localhost:43038/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43038/tests/dromaeo/cssquery-mootools.html) 04:52:32 INFO - PID 13666 | RSS: Main: 169267200 04:52:32 INFO - PID 13666 | 04:55:34 INFO - PID 13666 | Cycle 1(1): loaded http://localhost:43038/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43038/tests/dromaeo/cssquery-prototype.html) 04:55:35 INFO - PID 13666 | RSS: Main: 161673216 04:55:35 INFO - PID 13666 | 04:58:38 INFO - PID 13666 | Cycle 1(1): loaded http://localhost:43038/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43038/tests/dromaeo/cssquery-yui.html) 04:58:39 INFO - PID 13666 | RSS: Main: 168206336 04:58:39 INFO - PID 13666 | 05:01:41 INFO - PID 13666 | Cycle 1(1): loaded http://localhost:43038/tests/dromaeo/cssquery-yui.html (next: http://localhost:43038/tests/dromaeo/cssquery-dojo.html) 05:01:41 INFO - PID 13666 | RSS: Main: 161775616 05:01:41 INFO - PID 13666 | 05:01:41 INFO - PID 13666 | __start_tp_report 05:01:41 INFO - PID 13666 | _x_x_mozilla_page_load 05:01:41 INFO - PID 13666 | _x_x_mozilla_page_load_details 05:01:41 INFO - PID 13666 | |i|pagename|runs| 05:01:41 INFO - PID 13666 | |0;dojo.html;2683.2486903666972;2693.138195777352;2700.3924117073648;2716.7147449517793;2724.101046654604;5011.173156429185;5021.347224860772;5032.270320803481;5037.269595908591;5105.897882042357;5046.54581087702;5067.366579177603;5127;5151.845444636658;5155.871103222412;4641.419822522176;4676.672632915697;4679.485256621769;4684.110019096378;4697.718136911779;4703.43558772946;4738.526147385269;4739.2654138608395;4743.241081426972;4789.640776941726;4662.790174442158;4669.6497762667595;4671.182543054952;4714.858554243378;4742.2886567014875;4706.882327941828;4712.95287047132;4719.716816990957;4743.620510359163;4769.785359658824;4599.954000459986;4668.136394766979;4670.976645116787;4690.624750019991;4731.053789242131;4969.105560999019;5019;5032.043911656773;5078.111330517182;5138.7173705446185;5529.889402211933;5534.667919924817;5538.47384498472;5544.722763861791;5545.556355491551;5571.0807716726695;5585.050541407971;5586.13414920688;5587.469190426903;5608.719564021782;5037.773300201499;5096.745162741922;5188.714620695822;5201;5212.504812042887;5624.493795558419;5634.5210657093785;5641.323041235078;5664.150377443417;5685.77256909719;5283.1546952487415;5324.361076670824;5336.733163341895;5341.706206158621;5346.331708536433;5344.786208551692;5477.4796394342475;5481.725913704378;5485.670859748348;5498.147787093007;5456.61803673739;5459.12653975362;5461.208124821958;5462.2079798429;5469.972650136724;5440.591955603346;5440.646357986719;5443.346798384219;5448.945510544923;5459.235707001023;4647.744374059459;4655.906881862344;4655.95344046562;4661.254199328159;4663.650226233046;4030.8589199378466;4076.5923407658997;4082.2447847148374;4082.81627326771;4124.05146816234;4594.264917613166;4636.9536304637195;4723.551262630044;4733.455652599926;4793.784279707422;5555.583331250173;5575.972120139373;5583.888322233533;5593.496585307342;5608.074667679787;4711.481737008926;4722.291656251521;4734.715917044989;4750.61995040396;4764.523547645277;4838.056578967067;4964.677295975822;4976.0794253063295;4981.775820088104;5028.296038554532;5033.672811267256;5124.718140502308;5153.896922061613;5173.275741396283;5178.145605975123;5567.137093750475;5576.163575463713;5586.16207568868;5591.580631452576;5595.720213989202;5113.258577506315;5156.819511317086;5183.663061900965;5185.559227465707;5208.687478751287;5318.414974352895;5351.705656188947;5359.919601206063;5371.274877891435;5384.838454846361;5397.298351214317;5461.453854614507;5464.1257398816;5465.098258787256;5473.0969390050195;5249.4225635180865;5265.447128051499;5274.050670879125;5284.577233821208;5289.629725919149;5281.917206972638;5295.232191332312;5304.522592966651;5361.195820626937;5375.946240537544;5240;5241.056609810271;5346.599005074713;5350.839474815762;5368.248445217595;5233.162693968947;5315.123004704181;5369.48989845964;5373.865653358697;5374.032674118696;5154.845354639367;5210.1142805723875;5214.7914083436235;5229.163333866563;5240.790368385222 05:01:41 INFO - PID 13666 | |1;ext.html;682.846359569097;713.9750108746194;723.6092510044573;731.6305265840751;732.5934106570851;32249.67750322496;33000;33015.33969320615;33424.83287583565;33428.49857252137;31973.921695089804;32269.35461290773;32332.191695207574;32436.18909527257;32664.183395415126;2199.0324257326765;2366.3847399676124;2406.711194656644;2422.2733180046002;2424.0303878448585;2341.496578235679;2396.0415833666584;2405.867677277749;2407;2410.3853517353136;2382.5949588569983;2386.8448550844228;2396.820238482112;2408.6266628672583;2411.3007227903886;2397.1010870923315;2404.61526155816;2404.987975060131;2408.7350391456926;2415.504821511595;2214.71208742864;2231.966520502194;2236.2508559632543;2241.4060274027397;2251.9866060272943;32947.835260823784;33099.33801323984;33140.83429582861;33148.834255828806;33324.50013249803;2667.679878414583;2670.759631633143;2670.772984296337;2676.6386537817534;2683.0877501649534;22971.008721277474;23456.882715586482;23561.29316120502;23610.76389236103;23900.163494277618;2982.806117602349;2988.4770165221216;2989.088328059941;2990.8504574771173;2995.7303842654264;109845.45077274562;112778.43610781894;116069.41965290204;152964.2351788245;153424.23287883488;39566.2086758269;40416.79791601023;40534.18931621351;40549;40587.594124058975;41834.581654183676;42119.36820947688;42143.36784948228;42220.57779422228;42228.78885605614;12183.512659493521;12273.93863030697;12351.752964940652;12397.93801030989;12426.62720118398;9564.282678798978;9704.70885873425;9712.22302215821;9717.514124293899;9756.170725488271;12862.742745145044;12872.420741066675;12949.935250323688;12997.805032924514;13195.538156164681;5539.390667026624;5571.972140139354;5605.131204663284;5606.6636001840025;5649.802256920988;882.1002577371174;905.1898550797;907.8819753432011;914.7210100919284;938.8169306985072;20437.89781051085;21359.67960480594;21393.78606213949;21452.463688407915;21607.459813504473;979.8873129590046;981.0875885426622;988.6307464162187;999.2006394884064;1015.7105225010837;11186.552537898555;11265.943670281596;11276.718082048015;11307.208495405243;11320.660380188607;212059;212223;212779;213381;213694;42747;43039;43054.784726076796;43060.78469607632;43235;1189.149757923089;1257.503286201945;1259.552858735136;1259.8425196850394;1265.1144199060695;19771.209151633775;19793.802061979197;20578.58842823165;20997.475063122933;21049.263275785273;30080.548791767702;30254.54618180773;30338.69661303447;30346.84826575853;30408.695913041473;199435;200240;200289;200606;200994;28591.571126432704;28982.855085724437;29695.40609187761;30464.543031854984;30473.54289685612;37486;37980.620193798815;38590.614093858705;38901.805490972365;40218.59781402266;34231.657683423844;34257.314853702286;34494;34633.480497793054;34971.65028349786;33856.49215261724;33880;34032;34033;34475.82762086173;32564.185895351857;32771.34457310888;33524;33549.83225083859;33778.662213378535;29576;30765.23086922845;30788.076357709306;30885.536716948813;31083.844580776953;23661.763382366644;23983;24143;24145.18674381907;24467.75532244655 05:01:41 INFO - PID 13666 | |2;jquery.html;406.469557227818;413.8861813001424;420.37364327152534;437.3461674796179;447.9395281636978;11839.940800296008;13428.865711342884;16951.745723814136;17564.912175439138;17623;17338.219780109896;17572.384966526173;17658.117094145306;18151.546211344725;18288.451346459595;3849.672777813882;3982.960170398288;3984.0637450199324;4003.699722520808;4010.5989401059805;3845.61543845616;3926.254011737775;3978.124812541251;3989.4015897615445;4000.1999600079953;3957.5448823385245;3961.564227934925;3967.226390853785;3979.1444839359533;3981.2037592481474;3877.263319969197;3930.449737036817;3971.424143499191;3972.0069982504374;3972.781497017663;3633.1462106404974;3633.745637805355;3654.6162652921594;3656.3601369760186;3662.7802331859907;22561.210357637403;22871.085156593716;23046.53906921852;23132.884335578383;23299.76700232993;1579.8894077414586;1592.7133116039108;1598.440545808969;1634.4442889417537;1646.9670606587802;13245.337733113402;13463.865361346458;13836.30818459073;14305.499307524291;14584.124952502883;1708.8462038416478;1753.3512600337956;1771.884827486222;1781.901995390253;1796.9011704356255;75071.62464187643;83742.58128709378;84334.15665843325;85378;85651.99999999937;11022.779544409066;11198.440077996067;11268;11282.30243726929;11522.36626985507;16199.352025919066;16212.432564860173;16241.2691428886;16251.51245462638;16278.674426511403;7094.645267736592;7414.814629634195;7445.218252083561;7602.315791578784;7649.273319034683;6728.091707619409;6787.796366109024;6960.025596416505;6981.162260528769;7010.544314619533;7195;7205.89191162133;7207.315305046012;7210.495265331481;7321.487495875344;1959.7844237134188;2002.8097330753556;2004.2884775904636;2009.9749127944854;2158.848880578376;813.1949370123654;827.2637352756052;848.5841937450605;854.5812551849549;873.4191762478008;16904.40834570784;17208.65582688364;17354.566135846704;17605.911970440324;17788.199531021135;863.5854789700978;870.5821205821242;874.1433395272668;889.7241855024963;896.5382827843666;9054.185123338799;9589;9590.184834289024;9635.56639951204;9668.75828104303;218069;218388;218620;219036;219277;59146.945870960546;61142;70724.64637676779;72420.63789681018;84564.57717711372;1015.9593616255415;1044.1385856668278;1051.2536099369534;1051.5688567687212;1054.135608800776;17181.140942952552;17371.82628173702;17819.73270400919;17831.643367132845;17872.91063544726;38213.4267985986;40007.399889001106;40533.797331014335;40701;40771.38842917299;45828.77085614551;48075.5192448085;48292.7585362085;48532.75733621309;50473.49526504688;7717.726575115268;7958.602069896367;8037.67849286022;8064.274215320649;8321.54231517248;11402.20184587071;11609.187356884937;11655.59205427806;11742.412879356169;11904.880951190724;9788.559514821993;9796.804063918824;10142.847857281999;10203.795924081329;10261;10151.187904967437;10164.542595583069;10311.587536498457;10415.479226038819;10494.212934029825;9951.452670103214;10761.784764304826;10960.616378426717;11081.335119892832;11249.156313276373;7856.37149028065;7888.684452621831;8018.438709290293;8064.233897779936;8080.4343695940715;10375.94812025935;10464.267501274837;10614.73463163427;10785.62250321235;10865.402402867918 05:01:41 INFO - PID 13666 | |3;mootools.html;1292.9870701292987;1323.417696213666;1326.9004824638155;1333.2933545221024;1341.074658485645;9303.162715355616;9568.09103135202;9580.281478889076;9817.214622830174;10016.098551130397;9953.800923981516;10162.18702503798;10162.796744065132;10183.898161018387;10233.437160956144;2227.9777202228015;2255.6954811100536;2256.774322567738;2258.3337915314937;2258.6386178211487;2113.3131732187026;2180.160638154306;2184;2186.0381432169875;2192.2546334246354;2122.0556852200775;2154.6983422320886;2157.331227319536;2163.5889181055627;2170.1102547955343;2067.204126411335;2072.1814883121083;2073.40907841266;2076.6677331626865;2091.1321801452377;1703.3952946703866;1742.128935532234;2022.514596496845;2025.1190732031466;2132.243053715924;9337.90662093384;9483.90516094844;9485.33602647815;9497.5726092326;9530.904690953072;5327.334083239595;5503.2020357048;5542.334919809608;5546.223528705985;5562.694051827148;3215.581974343344;3248.1554795753036;3258.299465614904;3279.3769183854993;3324.384988777084;1028.8611037509916;1054.5465449856558;1057.5822550092748;1086.0280049355783;1094.7755710079493;14303.141811491343;14339.354729037219;14369.928150359287;14396.352164152533;14428;4430.335449682509;4578.313253012008;4688.203005489075;4826.734529600905;4864.513548645107;9979.051990060932;9979.80040399188;9989.600415983425;10045.095941365313;10069;5394.541463975606;5405.4324295949145;5411.269478620336;5413.756380962866;5424.403315635277;4663.183942809995;4739.336492890998;4832.492588278251;4908.9263661045115;4948;3619.49327094207;3675.834587443518;3711.721620878445;3751.118487155516;3791.374423220138;1073.2648136026692;1079.4656644960637;1079.5843600213818;1081.3565928272665;1084.1868598551087;654.2051407539861;676.5703778100843;690.0511796280115;690.899819526176;701.4493622506308;5345.65253258537;5362.544183744425;5493.697846618475;5510.9448905510435;5571.415001424792;795.7970717467009;799.7480793550013;806.5160903457878;809.2756982500629;811.975640730779;3134.7648926330617;3211.5022171563446;3224.822634755064;3258.1040213941355;3288.1943923738836;11909.166358355005;12183.45174467151;12251.93874030642;12257.632271031884;12307.384630768425;11900.107491938139;12074;12100.636980890587;12131.575394861315;12158;9000.909990900138;9436.056394360508;9441.339106262632;9446.574904129331;9448.527573621428;5325.307709997831;5355.839324820262;5424.972875135599;5426.972865135649;5455.536279416294;11265.380404077854;11293.322400655987;11305.547778088785;11354.205205635857;11445.885541144482;11711.238769479956;11730;11879;11910.225835321024;12020.33888136161;7401.59291238987;7623.237676232554;7645.120811106794;7652.502587331805;7665.23347665229;8980.86528702083;8983.371164018456;8988.685396011108;9051.502167380857;9123.77190570241;8097.595120243846;8119.431639785158;8210.507369557845;8225.054118776177;8426.873596895928;7947.046354437504;7963;8115.1479094694205;8247.422680412554;8368.497890126611;6888.621125838127;7023.789286321418;7026.894596581157;7029.718811247697;7040.190378106583;4947.480514546065;4959.925601116059;5001.399832020181;5053.974730126326;5232;4916.975415122902;4960.404751429707;4979.526944940225;5038.798448062036;5041.8487445376695 05:01:41 INFO - PID 13666 | |4;prototype.html;376.2625254501178;381.1196136923708;392.4780042543417;400.90779120802216;409.03875891654604;5337.5196232339085;5449.945500544994;5510.311211098608;5511.366192887819;5529.115341545354;5306.673331667083;5323.494268044539;5379.435159308275;5398.865028374293;5436.700981446019;4183.142455796569;4183.3097538906195;4184.518780340254;4198.097409057053;4221.501367014712;4034.435179074917;4196.664266858659;4205.201011807762;4214.557471465498;4249.723767955088;4177.49870015597;4190.664746820247;4196.895077623053;4197.467924207673;4199.097194103268;4191.916161676764;4205.621494065549;4210.705250632457;4231.280682283988;4236.428082208893;3601.7838929664304;3696.815159242027;3717.9922841665466;3722.7766334019775;3737.738358314919;5198.532132108091;5255.894882102375;5269.314989051437;5276.498732620395;5305.734713264322;4819.831305904277;4841.8063277468855;4851.490593487703;4861.611071114302;4883.829065982709;5595;5716.714164291769;5724.914126288068;5734.168545560912;5741.397153298927;4038.899027524306;4050.432939388488;4055.9391609125887;4058.0086493612725;4065.918681626351;5641.533201367674;5853.473187413153;5960.1357803118735;5992.2809262888295;6059.787907423219;4145.481814773153;4145.751254924714;4158.8336466540995;4174.519930208005;4176.181077772552;4216.789160542022;4222.1766755483;4223.13425747721;4227.217964676544;4241.34259189826;4743.549362810528;4775.331453596499;4802.591779698765;4811.49479304675;4827.25177597473;5717.971410142923;5720.77116915327;5736.7092404208715;5743.913841292384;5765.846830633806;1428.2002078835885;1463.817022872141;1466.8166479190102;1467.325030485967;1469.7501424757818;921.6808798726724;963.2486660404895;972.9416235025922;974.3910056214866;975.6877799104218;4940;4954.677945933503;4961.950380496221;4971.975140124348;4973.557668276232;5927.170196172539;5935.881282374328;5956.55325850563;5986.2517185351835;5986.341502434729;4835.274708793639;4906.901861962812;4959.851204463872;4978.701277923336;4981.950180498221;3081.892133775352;3099.2097015260965;3109.8134111953354;3121.438141134572;3132.1543183340373;5433.864153396196;5443.156310771837;5453.072977593819;5481.369642491085;5496.6701997880255;5807.622504537276;5953.732082056231;6039.396060394013;6049.969750151309;6074.878502429927;5397;5422.972885135628;5449.836504904859;5455.972720136374;5494.532964698045;5632.211490391431;5866.677332746569;5881.323822710507;5897.3807750185615;5941.494972927349;5800.361960184461;5845.743165219498;5846.853828654318;5849.327327357409;5868.119782032559;5157.381114266312;5286.286351342674;5334.919976200437;5419.3225846769155;5435.336685024231;4097.590240975878;4128.380742888591;4133.46264985562;4137.668986481134;4152.878722744782;5625.887482250414;5891.793787217427;5899.410058994066;5899.91150132757;5922.703864806828;5647.830565083054;5683.914741278802;5690.971545142248;5693.3168019837885;5700.429957004267;5685.715714214355;5692.117721753135;5707.343655479673;5723.5691077230695;5738.540916726568;5328.520433161034;5584.246126772996;5636.436356364331;5639.520640745583;5650.3219613646625;5693.686847223443;5706.9740242215075;5750.769969201185;5754.913676294943;5767;5492;5568.331800184003;5569.66582005081;5581;5602.187682785891 05:01:41 INFO - PID 13666 | |5;yui.html;688.9104416425864;691.3017851969511;692.0899017791606;722.4401089155904;726.1685370251059;12191.4513846877;12394.132410731252;12659.746805063893;12829.550965716202;12878.034147438933;12307.507699692023;12489.625311240654;12499.812502812465;12537.686557836036;13230.140040897335;836.3727204596553;837.2381133168817;850.8808766772656;851.8424091543053;855.5636625321068;867.3624885708999;870.2646263906988;871.0853603716105;872.0451106038877;878.056089703568;876.9517676527788;878.6573236437763;879.9824003519926;881.2685471059037;885.7829831691245;872.8647059705755;878.1613559051091;879.0681877210113;880.3925291548843;880.9779755506099;644.8291202831253;650.2229835346762;650.3106706890711;650.6421468192523;651.726274964516;13227.801582976263;13286.20282783036;13314.600561983156;13363.1313964592;14885.553433397015;13667.658308542266;14163.575092747235;14223.359948802225;14257.358418871176;14283.21442320672;10473.895261047368;10482.16366295646;10587.311824731369;10750.784984300348;10882.29265097774;2781.735735105162;2799.9860000699864;2814.1698199031334;2821.858907054639;2895.2327633177224;65397.67301163511;66726.66636666835;66816;68132.3186768136;68794.65602672004;10620;10698.572057117784;10712.196585256137;10806.891931080589;10880.564777408974;21973.890130549564;22017.22939697135;22117.447063823533;22204.222852200095;22287.108515659515;6691.631960242234;6731.562448440835;6789.25318214996;6795.456363491007;7024.824379390556;3285;3358.277970236411;3369.0735047862036;3370.494425836095;3424.6746559076846;3504.56192975878;3544.0962554548423;3552.236269202134;3568.1614820517157;3595.5146055282203;620.1380081686459;624.4130517313711;628.5066223014911;638.7093872288098;642.5887432043496;507.7131420747266;526.9736513174325;536.6699479819882;539.5710410223882;541.1530954056889;8359.331253499706;8549.27331176857;8615.526146061902;8652;8787.516686582172;540.2544488605699;575.2550447170923;575.6488541989384;580.3065336922422;581.9650820950757;3775.3770627846097;3837.908339954731;3906.843726250975;4007.539132999684;4031.899202519902;60633;61369;61585.152445426706;63750;64039;53816.73091634595;54571.72714136404;54739.45260547344;56553.71723141358;56878;36408;47651.99999999931;47720.28419573709;48056.759716201894;48738;7628.961855190689;7975;8149.307308878811;8153.266206041485;8170.223828736261;25898.352541185868;25998.22005339843;26514;26874;27196.456070878867;32620.673793261765;32659.673403265664;32660.510092349108;32804.34391312208;33521.16197095092;9920.206383489447;9979.950100249453;10122.342047766871;10205.84691229647;10376.533056012648;10996.890031099587;11014.339139651647;11071.391073491035;11161;11192.776144477228;9247.491387973458;9284;9386;9520.285978551497;9544;9823.705288841345;10245.641402550875;10375.63685271042;10652.201084918506;10665.253432259668;9764.93482577912;10115.39307641544;10115.544800483849;10223.131033862204;10568;8677.956610217161;8859.955700221457;8978.326625502983;8989.370744047854;9074.954625226832;7246.384057355184;8161.673533058849;8303.1281715419;8332.878011951021;8573.528455934735 05:01:41 INFO - PID 13666 | __end_tp_report 05:01:41 INFO - PID 13666 | __start_cc_report 05:01:41 INFO - PID 13666 | _x_x_mozilla_cycle_collect,381 05:01:41 INFO - PID 13666 | __end_cc_report 05:01:41 INFO - PID 13666 | __startTimestamp1490097701920__endTimestamp 05:01:41 INFO - PID 13666 | 05:01:41 INFO - PID 13666 | ------- Summary: start ------- 05:01:41 INFO - PID 13666 | Number of tests: 6 05:01:41 INFO - PID 13666 | 05:01:41 INFO - PID 13666 | [#0] dojo.html Cycles:165 Average:5057.17 Median:5188.71 stddev:554.89 (10.7%) stddev-sans-first:524.41 05:01:41 INFO - PID 13666 | Values: 2683.2 2693.1 2700.4 2716.7 2724.1 5011.2 5021.3 5032.3 5037.3 5105.9 5046.5 5067.4 5127.0 5151.8 5155.9 4641.4 4676.7 4679.5 4684.1 4697.7 4703.4 4738.5 4739.3 4743.2 4789.6 4662.8 4669.6 4671.2 4714.9 4742.3 4706.9 4713.0 4719.7 4743.6 4769.8 4600.0 4668.1 4671.0 4690.6 4731.1 4969.1 5019.0 5032.0 5078.1 5138.7 5529.9 5534.7 5538.5 5544.7 5545.6 5571.1 5585.1 5586.1 5587.5 5608.7 5037.8 5096.7 5188.7 5201.0 5212.5 5624.5 5634.5 5641.3 5664.2 5685.8 5283.2 5324.4 5336.7 5341.7 5346.3 5344.8 5477.5 5481.7 5485.7 5498.1 5456.6 5459.1 5461.2 5462.2 5470.0 5440.6 5440.6 5443.3 5448.9 5459.2 4647.7 4655.9 4656.0 4661.3 4663.7 4030.9 4076.6 4082.2 4082.8 4124.1 4594.3 4637.0 4723.6 4733.5 4793.8 5555.6 5576.0 5583.9 5593.5 5608.1 4711.5 4722.3 4734.7 4750.6 4764.5 4838.1 4964.7 4976.1 4981.8 5028.3 5033.7 5124.7 5153.9 5173.3 5178.1 5567.1 5576.2 5586.2 5591.6 5595.7 5113.3 5156.8 5183.7 5185.6 5208.7 5318.4 5351.7 5359.9 5371.3 5384.8 5397.3 5461.5 5464.1 5465.1 5473.1 5249.4 5265.4 5274.1 5284.6 5289.6 5281.9 5295.2 5304.5 5361.2 5375.9 5240.0 5241.1 5346.6 5350.8 5368.2 5233.2 5315.1 5369.5 5373.9 5374.0 5154.8 5210.1 5214.8 5229.2 5240.8 05:01:41 INFO - PID 13666 | 05:01:41 INFO - PID 13666 | [#1] ext.html Cycles:180 Average:32209.99 Median:2985.64 stddev:48411.31 (1621.5%) stddev-sans-first:48489.23 05:01:41 INFO - PID 13666 | Values: 682.8 714.0 723.6 731.6 732.6 32249.7 33000.0 33015.3 33424.8 33428.5 31973.9 32269.4 32332.2 32436.2 32664.2 2199.0 2366.4 2406.7 2422.3 2424.0 2341.5 2396.0 2405.9 2407.0 2410.4 2382.6 2386.8 2396.8 2408.6 2411.3 2397.1 2404.6 2405.0 2408.7 2415.5 2214.7 2232.0 2236.3 2241.4 2252.0 32947.8 33099.3 33140.8 33148.8 33324.5 2667.7 2670.8 2670.8 2676.6 2683.1 22971.0 23456.9 23561.3 23610.8 23900.2 2982.8 2988.5 2989.1 2990.9 2995.7 109845.5 112778.4 116069.4 152964.2 153424.2 39566.2 40416.8 40534.2 40549.0 40587.6 41834.6 42119.4 42143.4 42220.6 42228.8 12183.5 12273.9 12351.8 12397.9 12426.6 9564.3 9704.7 9712.2 9717.5 9756.2 12862.7 12872.4 12949.9 12997.8 13195.5 5539.4 5572.0 5605.1 5606.7 5649.8 882.1 905.2 907.9 914.7 938.8 20437.9 21359.7 21393.8 21452.5 21607.5 979.9 981.1 988.6 999.2 1015.7 11186.6 11265.9 11276.7 11307.2 11320.7 212059.0 212223.0 212779.0 213381.0 213694.0 42747.0 43039.0 43054.8 43060.8 43235.0 1189.1 1257.5 1259.6 1259.8 1265.1 19771.2 19793.8 20578.6 20997.5 21049.3 30080.5 30254.5 30338.7 30346.8 30408.7 199435.0 200240.0 200289.0 200606.0 200994.0 28591.6 28982.9 29695.4 30464.5 30473.5 37486.0 37980.6 38590.6 38901.8 40218.6 34231.7 34257.3 34494.0 34633.5 34971.7 33856.5 33880.0 34032.0 34033.0 34475.8 32564.2 32771.3 33524.0 33549.8 33778.7 29576.0 30765.2 30788.1 30885.5 31083.8 23661.8 23983.0 24143.0 24145.2 24467.8 05:01:41 INFO - PID 13666 | 05:01:41 INFO - PID 13666 | [#2] jquery.html Cycles:180 Average:20016.83 Median:3659.57 stddev:38278.48 (1046.0%) stddev-sans-first:38357.54 05:01:41 INFO - PID 13666 | Values: 406.5 413.9 420.4 437.3 447.9 11839.9 13428.9 16951.7 17564.9 17623.0 17338.2 17572.4 17658.1 18151.5 18288.5 3849.7 3983.0 3984.1 4003.7 4010.6 3845.6 3926.3 3978.1 3989.4 4000.2 3957.5 3961.6 3967.2 3979.1 3981.2 3877.3 3930.4 3971.4 3972.0 3972.8 3633.1 3633.7 3654.6 3656.4 3662.8 22561.2 22871.1 23046.5 23132.9 23299.8 1579.9 1592.7 1598.4 1634.4 1647.0 13245.3 13463.9 13836.3 14305.5 14584.1 1708.8 1753.4 1771.9 1781.9 1796.9 75071.6 83742.6 84334.2 85378.0 85652.0 11022.8 11198.4 11268.0 11282.3 11522.4 16199.4 16212.4 16241.3 16251.5 16278.7 7094.6 7414.8 7445.2 7602.3 7649.3 6728.1 6787.8 6960.0 6981.2 7010.5 7195.0 7205.9 7207.3 7210.5 7321.5 1959.8 2002.8 2004.3 2010.0 2158.8 813.2 827.3 848.6 854.6 873.4 16904.4 17208.7 17354.6 17605.9 17788.2 863.6 870.6 874.1 889.7 896.5 9054.2 9589.0 9590.2 9635.6 9668.8 218069.0 218388.0 218620.0 219036.0 219277.0 59146.9 61142.0 70724.6 72420.6 84564.6 1016.0 1044.1 1051.3 1051.6 1054.1 17181.1 17371.8 17819.7 17831.6 17872.9 38213.4 40007.4 40533.8 40701.0 40771.4 45828.8 48075.5 48292.8 48532.8 50473.5 7717.7 7958.6 8037.7 8064.3 8321.5 11402.2 11609.2 11655.6 11742.4 11904.9 9788.6 9796.8 10142.8 10203.8 10261.0 10151.2 10164.5 10311.6 10415.5 10494.2 9951.5 10761.8 10960.6 11081.3 11249.2 7856.4 7888.7 8018.4 8064.2 8080.4 10375.9 10464.3 10614.7 10785.6 10865.4 05:01:41 INFO - PID 13666 | 05:01:41 INFO - PID 13666 | [#3] mootools.html Cycles:180 Average:6039.41 Median:4713.77 stddev:3840.63 (81.5%) stddev-sans-first:3834.84 05:01:41 INFO - PID 13666 | Values: 1293.0 1323.4 1326.9 1333.3 1341.1 9303.2 9568.1 9580.3 9817.2 10016.1 9953.8 10162.2 10162.8 10183.9 10233.4 2228.0 2255.7 2256.8 2258.3 2258.6 2113.3 2180.2 2184.0 2186.0 2192.3 2122.1 2154.7 2157.3 2163.6 2170.1 2067.2 2072.2 2073.4 2076.7 2091.1 1703.4 1742.1 2022.5 2025.1 2132.2 9337.9 9483.9 9485.3 9497.6 9530.9 5327.3 5503.2 5542.3 5546.2 5562.7 3215.6 3248.2 3258.3 3279.4 3324.4 1028.9 1054.5 1057.6 1086.0 1094.8 14303.1 14339.4 14369.9 14396.4 14428.0 4430.3 4578.3 4688.2 4826.7 4864.5 9979.1 9979.8 9989.6 10045.1 10069.0 5394.5 5405.4 5411.3 5413.8 5424.4 4663.2 4739.3 4832.5 4908.9 4948.0 3619.5 3675.8 3711.7 3751.1 3791.4 1073.3 1079.5 1079.6 1081.4 1084.2 654.2 676.6 690.1 690.9 701.4 5345.7 5362.5 5493.7 5510.9 5571.4 795.8 799.7 806.5 809.3 812.0 3134.8 3211.5 3224.8 3258.1 3288.2 11909.2 12183.5 12251.9 12257.6 12307.4 11900.1 12074.0 12100.6 12131.6 12158.0 9000.9 9436.1 9441.3 9446.6 9448.5 5325.3 5355.8 5425.0 5427.0 5455.5 11265.4 11293.3 11305.5 11354.2 11445.9 11711.2 11730.0 11879.0 11910.2 12020.3 7401.6 7623.2 7645.1 7652.5 7665.2 8980.9 8983.4 8988.7 9051.5 9123.8 8097.6 8119.4 8210.5 8225.1 8426.9 7947.0 7963.0 8115.1 8247.4 8368.5 6888.6 7023.8 7026.9 7029.7 7040.2 4947.5 4959.9 5001.4 5054.0 5232.0 4917.0 4960.4 4979.5 5038.8 5041.8 05:01:41 INFO - PID 13666 | 05:01:41 INFO - PID 13666 | [#4] prototype.html Cycles:180 Average:4719.78 Median:5336.22 stddev:1370.37 (25.7%) stddev-sans-first:1334.87 05:01:41 INFO - PID 13666 | Values: 376.3 381.1 392.5 400.9 409.0 5337.5 5449.9 5510.3 5511.4 5529.1 5306.7 5323.5 5379.4 5398.9 5436.7 4183.1 4183.3 4184.5 4198.1 4221.5 4034.4 4196.7 4205.2 4214.6 4249.7 4177.5 4190.7 4196.9 4197.5 4199.1 4191.9 4205.6 4210.7 4231.3 4236.4 3601.8 3696.8 3718.0 3722.8 3737.7 5198.5 5255.9 5269.3 5276.5 5305.7 4819.8 4841.8 4851.5 4861.6 4883.8 5595.0 5716.7 5724.9 5734.2 5741.4 4038.9 4050.4 4055.9 4058.0 4065.9 5641.5 5853.5 5960.1 5992.3 6059.8 4145.5 4145.8 4158.8 4174.5 4176.2 4216.8 4222.2 4223.1 4227.2 4241.3 4743.5 4775.3 4802.6 4811.5 4827.3 5718.0 5720.8 5736.7 5743.9 5765.8 1428.2 1463.8 1466.8 1467.3 1469.8 921.7 963.2 972.9 974.4 975.7 4940.0 4954.7 4962.0 4972.0 4973.6 5927.2 5935.9 5956.6 5986.3 5986.3 4835.3 4906.9 4959.9 4978.7 4982.0 3081.9 3099.2 3109.8 3121.4 3132.2 5433.9 5443.2 5453.1 5481.4 5496.7 5807.6 5953.7 6039.4 6050.0 6074.9 5397.0 5423.0 5449.8 5456.0 5494.5 5632.2 5866.7 5881.3 5897.4 5941.5 5800.4 5845.7 5846.9 5849.3 5868.1 5157.4 5286.3 5334.9 5419.3 5435.3 4097.6 4128.4 4133.5 4137.7 4152.9 5625.9 5891.8 5899.4 5899.9 5922.7 5647.8 5683.9 5691.0 5693.3 5700.4 5685.7 5692.1 5707.3 5723.6 5738.5 5328.5 5584.2 5636.4 5639.5 5650.3 5693.7 5707.0 5750.8 5754.9 5767.0 5492.0 5568.3 5569.7 5581.0 5602.2 05:01:41 INFO - PID 13666 | 05:01:41 INFO - PID 13666 | [#5] yui.html Cycles:180 Average:13834.51 Median:539.91 stddev:17356.93 (3214.8%) stddev-sans-first:17377.55 05:01:41 INFO - PID 13666 | Values: 688.9 691.3 692.1 722.4 726.2 12191.5 12394.1 12659.7 12829.6 12878.0 12307.5 12489.6 12499.8 12537.7 13230.1 836.4 837.2 850.9 851.8 855.6 867.4 870.3 871.1 872.0 878.1 877.0 878.7 880.0 881.3 885.8 872.9 878.2 879.1 880.4 881.0 644.8 650.2 650.3 650.6 651.7 13227.8 13286.2 13314.6 13363.1 14885.6 13667.7 14163.6 14223.4 14257.4 14283.2 10473.9 10482.2 10587.3 10750.8 10882.3 2781.7 2800.0 2814.2 2821.9 2895.2 65397.7 66726.7 66816.0 68132.3 68794.7 10620.0 10698.6 10712.2 10806.9 10880.6 21973.9 22017.2 22117.4 22204.2 22287.1 6691.6 6731.6 6789.3 6795.5 7024.8 3285.0 3358.3 3369.1 3370.5 3424.7 3504.6 3544.1 3552.2 3568.2 3595.5 620.1 624.4 628.5 638.7 642.6 507.7 527.0 536.7 539.6 541.2 8359.3 8549.3 8615.5 8652.0 8787.5 540.3 575.3 575.6 580.3 582.0 3775.4 3837.9 3906.8 4007.5 4031.9 60633.0 61369.0 61585.2 63750.0 64039.0 53816.7 54571.7 54739.5 56553.7 56878.0 36408.0 47652.0 47720.3 48056.8 48738.0 7629.0 7975.0 8149.3 8153.3 8170.2 25898.4 25998.2 26514.0 26874.0 27196.5 32620.7 32659.7 32660.5 32804.3 33521.2 9920.2 9980.0 10122.3 10205.8 10376.5 10996.9 11014.3 11071.4 11161.0 11192.8 9247.5 9284.0 9386.0 9520.3 9544.0 9823.7 10245.6 10375.6 10652.2 10665.3 9764.9 10115.4 10115.5 10223.1 10568.0 8678.0 8860.0 8978.3 8989.4 9075.0 7246.4 8161.7 8303.1 8332.9 8573.5 05:01:41 INFO - PID 13666 | -------- Summary: end -------- 05:01:41 INFO - PID 13666 | 05:01:42 INFO - TEST-INFO | 13666: exit 0 05:01:42 INFO - TEST-OK | dromaeo_css | took 1121517ms 05:01:42 INFO - TEST-START | kraken 05:01:42 INFO - operating with platform_type : linux_ 05:01:42 INFO - Initialising browser for kraken test... 05:01:42 INFO - TEST-INFO | started process 14044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRe2Qxa/profile http://localhost:43038/getInfo.html) 05:01:47 INFO - PID 14044 | __metrics Screen width/height:1600/1200 05:01:47 INFO - PID 14044 | colorDepth:24 05:01:47 INFO - PID 14044 | Browser inner width/height: 1024/697 05:01:47 INFO - PID 14044 | __metrics 05:01:48 ERROR - PID 14044 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 05:01:50 INFO - TEST-INFO | 14044: exit 0 05:01:50 INFO - Browser initialized. 05:01:50 INFO - Running cycle 1/1 for kraken test... 05:01:50 INFO - TEST-INFO | started process 14174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRe2Qxa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:02 INFO - PID 14174 | RSS: Main: 155013120 05:02:02 INFO - PID 14174 | 05:02:04 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43038/tests/kraken/driver.html?testName=audio-beat-detection) 05:02:05 INFO - PID 14174 | RSS: Main: 160899072 05:02:05 INFO - PID 14174 | 05:02:08 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43038/tests/kraken/driver.html?testName=audio-dft) 05:02:09 INFO - PID 14174 | RSS: Main: 160866304 05:02:09 INFO - PID 14174 | 05:02:11 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43038/tests/kraken/driver.html?testName=audio-fft) 05:02:12 INFO - PID 14174 | RSS: Main: 157515776 05:02:12 INFO - PID 14174 | 05:02:14 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43038/tests/kraken/driver.html?testName=audio-oscillator) 05:02:15 INFO - PID 14174 | RSS: Main: 158126080 05:02:15 INFO - PID 14174 | 05:02:17 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43038/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:02:18 INFO - PID 14174 | RSS: Main: 158355456 05:02:18 INFO - PID 14174 | 05:02:21 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43038/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:22 INFO - PID 14174 | RSS: Main: 162955264 05:02:22 INFO - PID 14174 | 05:02:25 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43038/tests/kraken/driver.html?testName=imaging-desaturate) 05:02:26 INFO - PID 14174 | RSS: Main: 160976896 05:02:26 INFO - PID 14174 | 05:02:29 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43038/tests/kraken/driver.html?testName=json-parse-financial) 05:02:29 INFO - PID 14174 | RSS: Main: 161710080 05:02:29 INFO - PID 14174 | 05:02:31 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43038/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:02:32 INFO - PID 14174 | RSS: Main: 162701312 05:02:32 INFO - PID 14174 | 05:02:33 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:02:34 INFO - PID 14174 | RSS: Main: 162697216 05:02:34 INFO - PID 14174 | 05:02:36 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:02:37 INFO - PID 14174 | RSS: Main: 163143680 05:02:37 INFO - PID 14174 | 05:02:40 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:02:41 INFO - PID 14174 | RSS: Main: 163426304 05:02:41 INFO - PID 14174 | 05:02:44 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:02:45 INFO - PID 14174 | RSS: Main: 161107968 05:02:45 INFO - PID 14174 | 05:02:46 INFO - PID 14174 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43038/tests/kraken/driver.html?testName=ai-astar) 05:02:47 INFO - PID 14174 | RSS: Main: 162844672 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | __start_tp_report 05:02:47 INFO - PID 14174 | _x_x_mozilla_page_load 05:02:47 INFO - PID 14174 | _x_x_mozilla_page_load_details 05:02:47 INFO - PID 14174 | |i|pagename|runs| 05:02:47 INFO - PID 14174 | |0;ai-astar;104;114;112;110;111;110;111;113;114;110 05:02:47 INFO - PID 14174 | |1;audio-beat-detection;150;135;126;176;125;128;123;131;144;128 05:02:47 INFO - PID 14174 | |2;audio-dft;164;169;163;165;168;173;165;164;165;165 05:02:47 INFO - PID 14174 | |3;audio-fft;74;75;75;108;76;76;77;76;91;75 05:02:47 INFO - PID 14174 | |4;audio-oscillator;84;85;117;84;84;85;102;84;85;111 05:02:47 INFO - PID 14174 | |5;imaging-gaussian-blur;114;114;114;115;114;114;117;114;116;116 05:02:47 INFO - PID 14174 | |6;imaging-darkroom;151;150;151;152;150;152;150;150;152;151 05:02:47 INFO - PID 14174 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;95;94 05:02:47 INFO - PID 14174 | |8;json-parse-financial;69;69;69;70;69;70;69;70;70;71 05:02:47 INFO - PID 14174 | |9;json-stringify-tinderbox;55;60;55;55;56;56;56;56;59;55 05:02:47 INFO - PID 14174 | |10;stanford-crypto-aes;84;84;83;84;84;83;86;83;84;93 05:02:47 INFO - PID 14174 | |11;stanford-crypto-ccm;137;134;147;134;146;140;142;145;181;134 05:02:47 INFO - PID 14174 | |12;stanford-crypto-pbkdf2;184;200;197;212;205;197;196;198;187;203 05:02:47 INFO - PID 14174 | |13;stanford-crypto-sha256-iterative;72;74;72;74;76;70;72;72;78;70 05:02:47 INFO - PID 14174 | __end_tp_report 05:02:47 INFO - PID 14174 | __start_cc_report 05:02:47 INFO - PID 14174 | _x_x_mozilla_cycle_collect,882 05:02:47 INFO - PID 14174 | __end_cc_report 05:02:47 INFO - PID 14174 | __startTimestamp1490097767099__endTimestamp 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | ------- Summary: start ------- 05:02:47 INFO - PID 14174 | Number of tests: 14 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:2.88 (2.6%) stddev-sans-first:1.66 05:02:47 INFO - PID 14174 | Values: 104.0 114.0 112.0 110.0 111.0 110.0 111.0 113.0 114.0 110.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:133.00 stddev:16.33 (12.3%) stddev-sans-first:16.59 05:02:47 INFO - PID 14174 | Values: 150.0 135.0 126.0 176.0 125.0 128.0 123.0 131.0 144.0 128.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.00 stddev:3.03 (1.8%) stddev-sans-first:3.12 05:02:47 INFO - PID 14174 | Values: 164.0 169.0 163.0 165.0 168.0 173.0 165.0 164.0 165.0 165.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#3] audio-fft Cycles:10 Average:80.30 Median:76.00 stddev:10.91 (14.4%) stddev-sans-first:11.34 05:02:47 INFO - PID 14174 | Values: 74.0 75.0 75.0 108.0 76.0 76.0 77.0 76.0 91.0 75.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:84.00 stddev:12.86 (15.3%) stddev-sans-first:13.30 05:02:47 INFO - PID 14174 | Values: 84.0 85.0 117.0 84.0 84.0 85.0 102.0 84.0 85.0 111.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.50 stddev:1.14 (1.0%) stddev-sans-first:1.17 05:02:47 INFO - PID 14174 | Values: 114.0 114.0 114.0 115.0 114.0 114.0 117.0 114.0 116.0 116.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 05:02:47 INFO - PID 14174 | Values: 151.0 150.0 151.0 152.0 150.0 152.0 150.0 150.0 152.0 151.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:02:47 INFO - PID 14174 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#8] json-parse-financial Cycles:10 Average:69.60 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 05:02:47 INFO - PID 14174 | Values: 69.0 69.0 69.0 70.0 69.0 70.0 69.0 70.0 70.0 71.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:1.77 (3.2%) stddev-sans-first:1.81 05:02:47 INFO - PID 14174 | Values: 55.0 60.0 55.0 55.0 56.0 56.0 56.0 56.0 59.0 55.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.00 stddev:3.01 (3.6%) stddev-sans-first:3.18 05:02:47 INFO - PID 14174 | Values: 84.0 84.0 83.0 84.0 84.0 83.0 86.0 83.0 84.0 93.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:143.50 stddev:13.95 (9.7%) stddev-sans-first:14.57 05:02:47 INFO - PID 14174 | Values: 137.0 134.0 147.0 134.0 146.0 140.0 142.0 145.0 181.0 134.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.90 Median:199.00 stddev:8.14 (4.1%) stddev-sans-first:6.91 05:02:47 INFO - PID 14174 | Values: 184.0 200.0 197.0 212.0 205.0 197.0 196.0 198.0 187.0 203.0 05:02:47 INFO - PID 14174 | 05:02:47 INFO - PID 14174 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.00 stddev:2.54 (3.5%) stddev-sans-first:2.67 05:02:47 INFO - PID 14174 | Values: 72.0 74.0 72.0 74.0 76.0 70.0 72.0 72.0 78.0 70.0 05:02:47 INFO - PID 14174 | -------- Summary: end -------- 05:02:47 INFO - PID 14174 | 05:02:48 INFO - TEST-INFO | 14174: exit 0 05:02:48 INFO - TEST-OK | kraken | took 65482ms 05:02:48 INFO - SUITE-END | took 1186s 05:02:48 INFO - Completed test suite (00:19:47) 05:02:48 INFO - javascript benchmark 05:02:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6298.78865047473, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2683.2486903666972, 2693.138195777352, 2700.3924117073648, 2716.7147449517793, 2724.101046654604, 5011.173156429185, 5021.347224860772, 5032.270320803481, 5037.269595908591, 5105.897882042357, 5046.54581087702, 5067.366579177603, 5127.0, 5151.845444636658, 5155.871103222412, 4641.419822522176, 4676.672632915697, 4679.485256621769, 4684.110019096378, 4697.718136911779, 4703.43558772946, 4738.526147385269, 4739.2654138608395, 4743.241081426972, 4789.640776941726, 4662.790174442158, 4669.6497762667595, 4671.182543054952, 4714.858554243378, 4742.2886567014875, 4706.882327941828, 4712.95287047132, 4719.716816990957, 4743.620510359163, 4769.785359658824, 4599.954000459986, 4668.136394766979, 4670.976645116787, 4690.624750019991, 4731.053789242131, 4969.105560999019, 5019.0, 5032.043911656773, 5078.111330517182, 5138.7173705446185, 5529.889402211933, 5534.667919924817, 5538.47384498472, 5544.722763861791, 5545.556355491551, 5571.0807716726695, 5585.050541407971, 5586.13414920688, 5587.469190426903, 5608.719564021782, 5037.773300201499, 5096.745162741922, 5188.714620695822, 5201.0, 5212.504812042887, 5624.493795558419, 5634.5210657093785, 5641.323041235078, 5664.150377443417, 5685.77256909719, 5283.1546952487415, 5324.361076670824, 5336.733163341895, 5341.706206158621, 5346.331708536433, 5344.786208551692, 5477.4796394342475, 5481.725913704378, 5485.670859748348, 5498.147787093007, 5456.61803673739, 5459.12653975362, 5461.208124821958, 5462.2079798429, 5469.972650136724, 5440.591955603346, 5440.646357986719, 5443.346798384219, 5448.945510544923, 5459.235707001023, 4647.744374059459, 4655.906881862344, 4655.95344046562, 4661.254199328159, 4663.650226233046, 4030.8589199378466, 4076.5923407658997, 4082.2447847148374, 4082.81627326771, 4124.05146816234, 4594.264917613166, 4636.9536304637195, 4723.551262630044, 4733.455652599926, 4793.784279707422, 5555.583331250173, 5575.972120139373, 5583.888322233533, 5593.496585307342, 5608.074667679787, 4711.481737008926, 4722.291656251521, 4734.715917044989, 4750.61995040396, 4764.523547645277, 4838.056578967067, 4964.677295975822, 4976.0794253063295, 4981.775820088104, 5028.296038554532, 5033.672811267256, 5124.718140502308, 5153.896922061613, 5173.275741396283, 5178.145605975123, 5567.137093750475, 5576.163575463713, 5586.16207568868, 5591.580631452576, 5595.720213989202, 5113.258577506315, 5156.819511317086, 5183.663061900965, 5185.559227465707, 5208.687478751287, 5318.414974352895, 5351.705656188947, 5359.919601206063, 5371.274877891435, 5384.838454846361, 5397.298351214317, 5461.453854614507, 5464.1257398816, 5465.098258787256, 5473.0969390050195, 5249.4225635180865, 5265.447128051499, 5274.050670879125, 5284.577233821208, 5289.629725919149, 5281.917206972638, 5295.232191332312, 5304.522592966651, 5361.195820626937, 5375.946240537544, 5240.0, 5241.056609810271, 5346.599005074713, 5350.839474815762, 5368.248445217595, 5233.162693968947, 5315.123004704181, 5369.48989845964, 5373.865653358697, 5374.032674118696, 5154.845354639367, 5210.1142805723875, 5214.7914083436235, 5229.163333866563, 5240.790368385222], "value": 5018.974909785171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.846359569097, 713.9750108746194, 723.6092510044573, 731.6305265840751, 732.5934106570851, 32249.67750322496, 33000.0, 33015.33969320615, 33424.83287583565, 33428.49857252137, 31973.921695089804, 32269.35461290773, 32332.191695207574, 32436.18909527257, 32664.183395415126, 2199.0324257326765, 2366.3847399676124, 2406.711194656644, 2422.2733180046002, 2424.0303878448585, 2341.496578235679, 2396.0415833666584, 2405.867677277749, 2407.0, 2410.3853517353136, 2382.5949588569983, 2386.8448550844228, 2396.820238482112, 2408.6266628672583, 2411.3007227903886, 2397.1010870923315, 2404.61526155816, 2404.987975060131, 2408.7350391456926, 2415.504821511595, 2214.71208742864, 2231.966520502194, 2236.2508559632543, 2241.4060274027397, 2251.9866060272943, 32947.835260823784, 33099.33801323984, 33140.83429582861, 33148.834255828806, 33324.50013249803, 2667.679878414583, 2670.759631633143, 2670.772984296337, 2676.6386537817534, 2683.0877501649534, 22971.008721277474, 23456.882715586482, 23561.29316120502, 23610.76389236103, 23900.163494277618, 2982.806117602349, 2988.4770165221216, 2989.088328059941, 2990.8504574771173, 2995.7303842654264, 109845.45077274562, 112778.43610781894, 116069.41965290204, 152964.2351788245, 153424.23287883488, 39566.2086758269, 40416.79791601023, 40534.18931621351, 40549.0, 40587.594124058975, 41834.581654183676, 42119.36820947688, 42143.36784948228, 42220.57779422228, 42228.78885605614, 12183.512659493521, 12273.93863030697, 12351.752964940652, 12397.93801030989, 12426.62720118398, 9564.282678798978, 9704.70885873425, 9712.22302215821, 9717.514124293899, 9756.170725488271, 12862.742745145044, 12872.420741066675, 12949.935250323688, 12997.805032924514, 13195.538156164681, 5539.390667026624, 5571.972140139354, 5605.131204663284, 5606.6636001840025, 5649.802256920988, 882.1002577371174, 905.1898550797, 907.8819753432011, 914.7210100919284, 938.8169306985072, 20437.89781051085, 21359.67960480594, 21393.78606213949, 21452.463688407915, 21607.459813504473, 979.8873129590046, 981.0875885426622, 988.6307464162187, 999.2006394884064, 1015.7105225010837, 11186.552537898555, 11265.943670281596, 11276.718082048015, 11307.208495405243, 11320.660380188607, 212059.0, 212223.0, 212779.0, 213381.0, 213694.0, 42747.0, 43039.0, 43054.784726076796, 43060.78469607632, 43235.0, 1189.149757923089, 1257.503286201945, 1259.552858735136, 1259.8425196850394, 1265.1144199060695, 19771.209151633775, 19793.802061979197, 20578.58842823165, 20997.475063122933, 21049.263275785273, 30080.548791767702, 30254.54618180773, 30338.69661303447, 30346.84826575853, 30408.695913041473, 199435.0, 200240.0, 200289.0, 200606.0, 200994.0, 28591.571126432704, 28982.855085724437, 29695.40609187761, 30464.543031854984, 30473.54289685612, 37486.0, 37980.620193798815, 38590.614093858705, 38901.805490972365, 40218.59781402266, 34231.657683423844, 34257.314853702286, 34494.0, 34633.480497793054, 34971.65028349786, 33856.49215261724, 33880.0, 34032.0, 34033.0, 34475.82762086173, 32564.185895351857, 32771.34457310888, 33524.0, 33549.83225083859, 33778.662213378535, 29576.0, 30765.23086922845, 30788.076357709306, 30885.536716948813, 31083.844580776953, 23661.763382366644, 23983.0, 24143.0, 24145.18674381907, 24467.75532244655], "value": 12772.731233267326, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.469557227818, 413.8861813001424, 420.37364327152534, 437.3461674796179, 447.9395281636978, 11839.940800296008, 13428.865711342884, 16951.745723814136, 17564.912175439138, 17623.0, 17338.219780109896, 17572.384966526173, 17658.117094145306, 18151.546211344725, 18288.451346459595, 3849.672777813882, 3982.960170398288, 3984.0637450199324, 4003.699722520808, 4010.5989401059805, 3845.61543845616, 3926.254011737775, 3978.124812541251, 3989.4015897615445, 4000.1999600079953, 3957.5448823385245, 3961.564227934925, 3967.226390853785, 3979.1444839359533, 3981.2037592481474, 3877.263319969197, 3930.449737036817, 3971.424143499191, 3972.0069982504374, 3972.781497017663, 3633.1462106404974, 3633.745637805355, 3654.6162652921594, 3656.3601369760186, 3662.7802331859907, 22561.210357637403, 22871.085156593716, 23046.53906921852, 23132.884335578383, 23299.76700232993, 1579.8894077414586, 1592.7133116039108, 1598.440545808969, 1634.4442889417537, 1646.9670606587802, 13245.337733113402, 13463.865361346458, 13836.30818459073, 14305.499307524291, 14584.124952502883, 1708.8462038416478, 1753.3512600337956, 1771.884827486222, 1781.901995390253, 1796.9011704356255, 75071.62464187643, 83742.58128709378, 84334.15665843325, 85378.0, 85651.99999999937, 11022.779544409066, 11198.440077996067, 11268.0, 11282.30243726929, 11522.36626985507, 16199.352025919066, 16212.432564860173, 16241.2691428886, 16251.51245462638, 16278.674426511403, 7094.645267736592, 7414.814629634195, 7445.218252083561, 7602.315791578784, 7649.273319034683, 6728.091707619409, 6787.796366109024, 6960.025596416505, 6981.162260528769, 7010.544314619533, 7195.0, 7205.89191162133, 7207.315305046012, 7210.495265331481, 7321.487495875344, 1959.7844237134188, 2002.8097330753556, 2004.2884775904636, 2009.9749127944854, 2158.848880578376, 813.1949370123654, 827.2637352756052, 848.5841937450605, 854.5812551849549, 873.4191762478008, 16904.40834570784, 17208.65582688364, 17354.566135846704, 17605.911970440324, 17788.199531021135, 863.5854789700978, 870.5821205821242, 874.1433395272668, 889.7241855024963, 896.5382827843666, 9054.185123338799, 9589.0, 9590.184834289024, 9635.56639951204, 9668.75828104303, 218069.0, 218388.0, 218620.0, 219036.0, 219277.0, 59146.945870960546, 61142.0, 70724.64637676779, 72420.63789681018, 84564.57717711372, 1015.9593616255415, 1044.1385856668278, 1051.2536099369534, 1051.5688567687212, 1054.135608800776, 17181.140942952552, 17371.82628173702, 17819.73270400919, 17831.643367132845, 17872.91063544726, 38213.4267985986, 40007.399889001106, 40533.797331014335, 40701.0, 40771.38842917299, 45828.77085614551, 48075.5192448085, 48292.7585362085, 48532.75733621309, 50473.49526504688, 7717.726575115268, 7958.602069896367, 8037.67849286022, 8064.274215320649, 8321.54231517248, 11402.20184587071, 11609.187356884937, 11655.59205427806, 11742.412879356169, 11904.880951190724, 9788.559514821993, 9796.804063918824, 10142.847857281999, 10203.795924081329, 10261.0, 10151.187904967437, 10164.542595583069, 10311.587536498457, 10415.479226038819, 10494.212934029825, 9951.452670103214, 10761.784764304826, 10960.616378426717, 11081.335119892832, 11249.156313276373, 7856.37149028065, 7888.684452621831, 8018.438709290293, 8064.233897779936, 8080.4343695940715, 10375.94812025935, 10464.267501274837, 10614.73463163427, 10785.62250321235, 10865.402402867918], "value": 8151.47634389039, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.9870701292987, 1323.417696213666, 1326.9004824638155, 1333.2933545221024, 1341.074658485645, 9303.162715355616, 9568.09103135202, 9580.281478889076, 9817.214622830174, 10016.098551130397, 9953.800923981516, 10162.18702503798, 10162.796744065132, 10183.898161018387, 10233.437160956144, 2227.9777202228015, 2255.6954811100536, 2256.774322567738, 2258.3337915314937, 2258.6386178211487, 2113.3131732187026, 2180.160638154306, 2184.0, 2186.0381432169875, 2192.2546334246354, 2122.0556852200775, 2154.6983422320886, 2157.331227319536, 2163.5889181055627, 2170.1102547955343, 2067.204126411335, 2072.1814883121083, 2073.40907841266, 2076.6677331626865, 2091.1321801452377, 1703.3952946703866, 1742.128935532234, 2022.514596496845, 2025.1190732031466, 2132.243053715924, 9337.90662093384, 9483.90516094844, 9485.33602647815, 9497.5726092326, 9530.904690953072, 5327.334083239595, 5503.2020357048, 5542.334919809608, 5546.223528705985, 5562.694051827148, 3215.581974343344, 3248.1554795753036, 3258.299465614904, 3279.3769183854993, 3324.384988777084, 1028.8611037509916, 1054.5465449856558, 1057.5822550092748, 1086.0280049355783, 1094.7755710079493, 14303.141811491343, 14339.354729037219, 14369.928150359287, 14396.352164152533, 14428.0, 4430.335449682509, 4578.313253012008, 4688.203005489075, 4826.734529600905, 4864.513548645107, 9979.051990060932, 9979.80040399188, 9989.600415983425, 10045.095941365313, 10069.0, 5394.541463975606, 5405.4324295949145, 5411.269478620336, 5413.756380962866, 5424.403315635277, 4663.183942809995, 4739.336492890998, 4832.492588278251, 4908.9263661045115, 4948.0, 3619.49327094207, 3675.834587443518, 3711.721620878445, 3751.118487155516, 3791.374423220138, 1073.2648136026692, 1079.4656644960637, 1079.5843600213818, 1081.3565928272665, 1084.1868598551087, 654.2051407539861, 676.5703778100843, 690.0511796280115, 690.899819526176, 701.4493622506308, 5345.65253258537, 5362.544183744425, 5493.697846618475, 5510.9448905510435, 5571.415001424792, 795.7970717467009, 799.7480793550013, 806.5160903457878, 809.2756982500629, 811.975640730779, 3134.7648926330617, 3211.5022171563446, 3224.822634755064, 3258.1040213941355, 3288.1943923738836, 11909.166358355005, 12183.45174467151, 12251.93874030642, 12257.632271031884, 12307.384630768425, 11900.107491938139, 12074.0, 12100.636980890587, 12131.575394861315, 12158.0, 9000.909990900138, 9436.056394360508, 9441.339106262632, 9446.574904129331, 9448.527573621428, 5325.307709997831, 5355.839324820262, 5424.972875135599, 5426.972865135649, 5455.536279416294, 11265.380404077854, 11293.322400655987, 11305.547778088785, 11354.205205635857, 11445.885541144482, 11711.238769479956, 11730.0, 11879.0, 11910.225835321024, 12020.33888136161, 7401.59291238987, 7623.237676232554, 7645.120811106794, 7652.502587331805, 7665.23347665229, 8980.86528702083, 8983.371164018456, 8988.685396011108, 9051.502167380857, 9123.77190570241, 8097.595120243846, 8119.431639785158, 8210.507369557845, 8225.054118776177, 8426.873596895928, 7947.046354437504, 7963.0, 8115.1479094694205, 8247.422680412554, 8368.497890126611, 6888.621125838127, 7023.789286321418, 7026.894596581157, 7029.718811247697, 7040.190378106583, 4947.480514546065, 4959.925601116059, 5001.399832020181, 5053.974730126326, 5232.0, 4916.975415122902, 4960.404751429707, 4979.526944940225, 5038.798448062036, 5041.8487445376695], "value": 4562.796359265488, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.2625254501178, 381.1196136923708, 392.4780042543417, 400.90779120802216, 409.03875891654604, 5337.5196232339085, 5449.945500544994, 5510.311211098608, 5511.366192887819, 5529.115341545354, 5306.673331667083, 5323.494268044539, 5379.435159308275, 5398.865028374293, 5436.700981446019, 4183.142455796569, 4183.3097538906195, 4184.518780340254, 4198.097409057053, 4221.501367014712, 4034.435179074917, 4196.664266858659, 4205.201011807762, 4214.557471465498, 4249.723767955088, 4177.49870015597, 4190.664746820247, 4196.895077623053, 4197.467924207673, 4199.097194103268, 4191.916161676764, 4205.621494065549, 4210.705250632457, 4231.280682283988, 4236.428082208893, 3601.7838929664304, 3696.815159242027, 3717.9922841665466, 3722.7766334019775, 3737.738358314919, 5198.532132108091, 5255.894882102375, 5269.314989051437, 5276.498732620395, 5305.734713264322, 4819.831305904277, 4841.8063277468855, 4851.490593487703, 4861.611071114302, 4883.829065982709, 5595.0, 5716.714164291769, 5724.914126288068, 5734.168545560912, 5741.397153298927, 4038.899027524306, 4050.432939388488, 4055.9391609125887, 4058.0086493612725, 4065.918681626351, 5641.533201367674, 5853.473187413153, 5960.1357803118735, 5992.2809262888295, 6059.787907423219, 4145.481814773153, 4145.751254924714, 4158.8336466540995, 4174.519930208005, 4176.181077772552, 4216.789160542022, 4222.1766755483, 4223.13425747721, 4227.217964676544, 4241.34259189826, 4743.549362810528, 4775.331453596499, 4802.591779698765, 4811.49479304675, 4827.25177597473, 5717.971410142923, 5720.77116915327, 5736.7092404208715, 5743.913841292384, 5765.846830633806, 1428.2002078835885, 1463.817022872141, 1466.8166479190102, 1467.325030485967, 1469.7501424757818, 921.6808798726724, 963.2486660404895, 972.9416235025922, 974.3910056214866, 975.6877799104218, 4940.0, 4954.677945933503, 4961.950380496221, 4971.975140124348, 4973.557668276232, 5927.170196172539, 5935.881282374328, 5956.55325850563, 5986.2517185351835, 5986.341502434729, 4835.274708793639, 4906.901861962812, 4959.851204463872, 4978.701277923336, 4981.950180498221, 3081.892133775352, 3099.2097015260965, 3109.8134111953354, 3121.438141134572, 3132.1543183340373, 5433.864153396196, 5443.156310771837, 5453.072977593819, 5481.369642491085, 5496.6701997880255, 5807.622504537276, 5953.732082056231, 6039.396060394013, 6049.969750151309, 6074.878502429927, 5397.0, 5422.972885135628, 5449.836504904859, 5455.972720136374, 5494.532964698045, 5632.211490391431, 5866.677332746569, 5881.323822710507, 5897.3807750185615, 5941.494972927349, 5800.361960184461, 5845.743165219498, 5846.853828654318, 5849.327327357409, 5868.119782032559, 5157.381114266312, 5286.286351342674, 5334.919976200437, 5419.3225846769155, 5435.336685024231, 4097.590240975878, 4128.380742888591, 4133.46264985562, 4137.668986481134, 4152.878722744782, 5625.887482250414, 5891.793787217427, 5899.410058994066, 5899.91150132757, 5922.703864806828, 5647.830565083054, 5683.914741278802, 5690.971545142248, 5693.3168019837885, 5700.429957004267, 5685.715714214355, 5692.117721753135, 5707.343655479673, 5723.5691077230695, 5738.540916726568, 5328.520433161034, 5584.246126772996, 5636.436356364331, 5639.520640745583, 5650.3219613646625, 5693.686847223443, 5706.9740242215075, 5750.769969201185, 5754.913676294943, 5767.0, 5492.0, 5568.331800184003, 5569.66582005081, 5581.0, 5602.187682785891], "value": 4299.774575479906, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.9104416425864, 691.3017851969511, 692.0899017791606, 722.4401089155904, 726.1685370251059, 12191.4513846877, 12394.132410731252, 12659.746805063893, 12829.550965716202, 12878.034147438933, 12307.507699692023, 12489.625311240654, 12499.812502812465, 12537.686557836036, 13230.140040897335, 836.3727204596553, 837.2381133168817, 850.8808766772656, 851.8424091543053, 855.5636625321068, 867.3624885708999, 870.2646263906988, 871.0853603716105, 872.0451106038877, 878.056089703568, 876.9517676527788, 878.6573236437763, 879.9824003519926, 881.2685471059037, 885.7829831691245, 872.8647059705755, 878.1613559051091, 879.0681877210113, 880.3925291548843, 880.9779755506099, 644.8291202831253, 650.2229835346762, 650.3106706890711, 650.6421468192523, 651.726274964516, 13227.801582976263, 13286.20282783036, 13314.600561983156, 13363.1313964592, 14885.553433397015, 13667.658308542266, 14163.575092747235, 14223.359948802225, 14257.358418871176, 14283.21442320672, 10473.895261047368, 10482.16366295646, 10587.311824731369, 10750.784984300348, 10882.29265097774, 2781.735735105162, 2799.9860000699864, 2814.1698199031334, 2821.858907054639, 2895.2327633177224, 65397.67301163511, 66726.66636666835, 66816.0, 68132.3186768136, 68794.65602672004, 10620.0, 10698.572057117784, 10712.196585256137, 10806.891931080589, 10880.564777408974, 21973.890130549564, 22017.22939697135, 22117.447063823533, 22204.222852200095, 22287.108515659515, 6691.631960242234, 6731.562448440835, 6789.25318214996, 6795.456363491007, 7024.824379390556, 3285.0, 3358.277970236411, 3369.0735047862036, 3370.494425836095, 3424.6746559076846, 3504.56192975878, 3544.0962554548423, 3552.236269202134, 3568.1614820517157, 3595.5146055282203, 620.1380081686459, 624.4130517313711, 628.5066223014911, 638.7093872288098, 642.5887432043496, 507.7131420747266, 526.9736513174325, 536.6699479819882, 539.5710410223882, 541.1530954056889, 8359.331253499706, 8549.27331176857, 8615.526146061902, 8652.0, 8787.516686582172, 540.2544488605699, 575.2550447170923, 575.6488541989384, 580.3065336922422, 581.9650820950757, 3775.3770627846097, 3837.908339954731, 3906.843726250975, 4007.539132999684, 4031.899202519902, 60633.0, 61369.0, 61585.152445426706, 63750.0, 64039.0, 53816.73091634595, 54571.72714136404, 54739.45260547344, 56553.71723141358, 56878.0, 36408.0, 47651.99999999931, 47720.28419573709, 48056.759716201894, 48738.0, 7628.961855190689, 7975.0, 8149.307308878811, 8153.266206041485, 8170.223828736261, 25898.352541185868, 25998.22005339843, 26514.0, 26874.0, 27196.456070878867, 32620.673793261765, 32659.673403265664, 32660.510092349108, 32804.34391312208, 33521.16197095092, 9920.206383489447, 9979.950100249453, 10122.342047766871, 10205.84691229647, 10376.533056012648, 10996.890031099587, 11014.339139651647, 11071.391073491035, 11161.0, 11192.776144477228, 9247.491387973458, 9284.0, 9386.0, 9520.285978551497, 9544.0, 9823.705288841345, 10245.641402550875, 10375.63685271042, 10652.201084918506, 10665.253432259668, 9764.93482577912, 10115.39307641544, 10115.544800483849, 10223.131033862204, 10568.0, 8677.956610217161, 8859.955700221457, 8978.326625502983, 8989.370744047854, 9074.954625226832, 7246.384057355184, 8161.673533058849, 8303.1281715419, 8332.878011951021, 8573.528455934735], "value": 6091.198888276137, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 112.0, 110.0, 111.0, 110.0, 111.0, 113.0, 114.0, 110.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 135.0, 126.0, 176.0, 125.0, 128.0, 123.0, 131.0, 144.0, 128.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 163.0, 165.0, 168.0, 173.0, 165.0, 164.0, 165.0, 165.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 108.0, 76.0, 76.0, 77.0, 76.0, 91.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 117.0, 84.0, 84.0, 85.0, 102.0, 84.0, 85.0, 111.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 117.0, 114.0, 116.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 152.0, 150.0, 152.0, 150.0, 150.0, 152.0, 151.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 70.0, 69.0, 70.0, 69.0, 70.0, 70.0, 71.0], "value": 69.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0, 59.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 84.0, 84.0, 83.0, 86.0, 83.0, 84.0, 93.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 147.0, 134.0, 146.0, 140.0, 142.0, 145.0, 181.0, 134.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 200.0, 197.0, 212.0, 205.0, 197.0, 196.0, 198.0, 187.0, 203.0], "value": 197.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 72.0, 74.0, 76.0, 70.0, 72.0, 72.0, 78.0, 70.0], "value": 73.0, "unit": "score"}]}]} 05:02:48 INFO - Return code: 0 05:02:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:02:48 ERROR - # TBPL SUCCESS # 05:02:48 INFO - Running post-action listener: _resource_record_post_action 05:02:48 INFO - [mozharness: 2017-03-21 12:02:48.868204Z] Finished run-tests step (success) 05:02:48 INFO - Running post-run listener: _resource_record_post_run 05:02:48 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 361062400; Read time: 12; Write time: 529428 05:02:48 INFO - TinderboxPrint: CPU usage
13.3% 05:02:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:02:48 INFO - TinderboxPrint: I/O write bytes / time
361,062,400 / 529,428 05:02:48 INFO - TinderboxPrint: CPU idle
8,319.3 (86.6%) 05:02:48 INFO - TinderboxPrint: CPU user
1,219.4 (12.7%) 05:02:48 INFO - TinderboxPrint: Swap in / out
0 / 0 05:02:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 63406080; Read time: 0; Write time: 191212 05:02:48 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254713856; Read time: 12; Write time: 318864 05:02:49 INFO - Running post-run listener: _upload_blobber_files 05:02:49 INFO - Blob upload gear active. 05:02:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:02:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:02:49 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:02:49 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:02:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:02:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:02:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:02:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:51 INFO - (blobuploader) - INFO - Done attempting. 05:02:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:02:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:55 INFO - (blobuploader) - INFO - Done attempting. 05:02:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:02:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:02:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:56 INFO - (blobuploader) - INFO - Done attempting. 05:02:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:02:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:02:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:56 INFO - (blobuploader) - INFO - Done attempting. 05:02:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:02:56 INFO - Return code: 0 05:02:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:02:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:02:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9c0af6f662263b3be60061d719824ea857f85983ba68d7e05639a6bd32c6868f1004f60d57a8d0e76a266a654394b30b697d1be17c62800fbb75854e5a91f75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a3d9cfc5ed639ef04a5e8761d838466d6340ad07fbeab233fcadb04e6ffa6ccb6b51e591f5e96168f2aac53ea4b5f47f598b7190d9200c03497d614c9a52fcb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7bb2eb4f1f3e51d71bb2bd466fdd5e70d8e83d05b528719dbf8d5e207f392647901191ba28254de332967ee0aa64488b657eaf72f002509c810af95b097a39f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2852316b03e2374ee5545579dcf297c6e1d0ba05a5782f40ca878e790a9552eec5f1604e7e2cdbfe9d59c8d3603849808b490a02dfc551b34574c21cab0eef21"} 05:02:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:02:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:02:56 INFO - Contents: 05:02:56 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9c0af6f662263b3be60061d719824ea857f85983ba68d7e05639a6bd32c6868f1004f60d57a8d0e76a266a654394b30b697d1be17c62800fbb75854e5a91f75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a3d9cfc5ed639ef04a5e8761d838466d6340ad07fbeab233fcadb04e6ffa6ccb6b51e591f5e96168f2aac53ea4b5f47f598b7190d9200c03497d614c9a52fcb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7bb2eb4f1f3e51d71bb2bd466fdd5e70d8e83d05b528719dbf8d5e207f392647901191ba28254de332967ee0aa64488b657eaf72f002509c810af95b097a39f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2852316b03e2374ee5545579dcf297c6e1d0ba05a5782f40ca878e790a9552eec5f1604e7e2cdbfe9d59c8d3603849808b490a02dfc551b34574c21cab0eef21"} 05:02:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:02:56 INFO - Copying logs to upload dir... 05:02:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:02:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.832133 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-03-21 05:02:56.557630) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 05:02:56.561598) ========= 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=df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9c0af6f662263b3be60061d719824ea857f85983ba68d7e05639a6bd32c6868f1004f60d57a8d0e76a266a654394b30b697d1be17c62800fbb75854e5a91f75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a3d9cfc5ed639ef04a5e8761d838466d6340ad07fbeab233fcadb04e6ffa6ccb6b51e591f5e96168f2aac53ea4b5f47f598b7190d9200c03497d614c9a52fcb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7bb2eb4f1f3e51d71bb2bd466fdd5e70d8e83d05b528719dbf8d5e207f392647901191ba28254de332967ee0aa64488b657eaf72f002509c810af95b097a39f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2852316b03e2374ee5545579dcf297c6e1d0ba05a5782f40ca878e790a9552eec5f1604e7e2cdbfe9d59c8d3603849808b490a02dfc551b34574c21cab0eef21"} build_url:https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://queue.taskcluster.net/v1/task/I_vxfnIMQB-pm-wi5cde3w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9c0af6f662263b3be60061d719824ea857f85983ba68d7e05639a6bd32c6868f1004f60d57a8d0e76a266a654394b30b697d1be17c62800fbb75854e5a91f75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a3d9cfc5ed639ef04a5e8761d838466d6340ad07fbeab233fcadb04e6ffa6ccb6b51e591f5e96168f2aac53ea4b5f47f598b7190d9200c03497d614c9a52fcb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7bb2eb4f1f3e51d71bb2bd466fdd5e70d8e83d05b528719dbf8d5e207f392647901191ba28254de332967ee0aa64488b657eaf72f002509c810af95b097a39f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2852316b03e2374ee5545579dcf297c6e1d0ba05a5782f40ca878e790a9552eec5f1604e7e2cdbfe9d59c8d3603849808b490a02dfc551b34574c21cab0eef21"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 05:02:56.586975) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 05:02:56.587333) ========= 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=df17445c3590ff7897617a0e00000225-1490096492.972195-1608775061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 05:02:56.672203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 05:02:56.672565) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 05:02:56.672884) ========= ========= Total master_lag: 0.18 =========